builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-021 starttime: 1464783056.11 results: success (0) buildid: 20160601021650 builduid: 1548571e00b64466a2baddee8cc67cdc revision: b73cfa00dab309c8b999550363df0c0456128b90 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-01 05:10:56.115159) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-01 05:10:56.115872) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-01 05:10:56.116337) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-01 05:10:56.132247) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 05:10:56.133497) ========= 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=df17445c3590ff7897617a0e00000225-1464783055.605947-1892751329 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-01 05:10:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 24.4M=0s 2016-06-01 05:10:56 (24.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.136928 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 05:10:56.285118) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 05:10:56.285433) ========= 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=df17445c3590ff7897617a0e00000225-1464783055.605947-1892751329 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017679 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 05:10:56.335433) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 05:10:56.335861) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b73cfa00dab309c8b999550363df0c0456128b90 --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 b73cfa00dab309c8b999550363df0c0456128b90 --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=df17445c3590ff7897617a0e00000225-1464783055.605947-1892751329 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-01 05:10:56,547 truncating revision to first 12 chars 2016-06-01 05:10:56,548 Setting DEBUG logging. 2016-06-01 05:10:56,548 attempt 1/10 2016-06-01 05:10:56,548 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/b73cfa00dab3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-01 05:10:56,939 unpacking tar archive at: mozilla-aurora-b73cfa00dab3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.728981 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 05:10:57.078285) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-01 05:10:57.078629) ========= script_repo_revision: b73cfa00dab309c8b999550363df0c0456128b90 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-01 05:10:57.079103) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-01 05:10:57.079372) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-01 05:10:57.089582) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-06-01 05:10:57.089877) ========= /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=df17445c3590ff7897617a0e00000225-1464783055.605947-1892751329 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:10:57 INFO - MultiFileLogger online at 20160601 05:10:57 in /builds/slave/test 05:10:57 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 05:10:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:10:57 INFO - {'append_to_log': False, 05:10:57 INFO - 'base_work_dir': '/builds/slave/test', 05:10:57 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 05:10:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:10:57 INFO - 'branch': 'Mozilla-Aurora', 05:10:57 INFO - 'buildbot_json_path': 'buildprops.json', 05:10:57 INFO - 'config_files': ('talos/linux_config.py',), 05:10:57 INFO - 'default_actions': ('clobber', 05:10:57 INFO - 'read-buildbot-config', 05:10:57 INFO - 'download-and-extract', 05:10:57 INFO - 'populate-webroot', 05:10:57 INFO - 'create-virtualenv', 05:10:57 INFO - 'install', 05:10:57 INFO - 'run-tests'), 05:10:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:10:57 INFO - 'download_minidump_stackwalk': True, 05:10:57 INFO - 'download_symbols': 'ondemand', 05:10:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:10:57 INFO - 'tooltool.py': '/tools/tooltool.py', 05:10:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:10:57 INFO - '/tools/misc-python/virtualenv.py')}, 05:10:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:10:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:10:57 INFO - 'installer_path': 'installer.exe', 05:10:57 INFO - 'log_level': 'info', 05:10:57 INFO - 'log_name': 'talos', 05:10:57 INFO - 'log_to_console': True, 05:10:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:10:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:10:57 INFO - 'opt_config_files': (), 05:10:57 INFO - 'pip_index': False, 05:10:57 INFO - 'sps_profile': False, 05:10:57 INFO - 'sps_profile_interval': 0, 05:10:57 INFO - 'suite': 'dromaeojs-e10s', 05:10:57 INFO - 'system_bits': '32', 05:10:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:10:57 INFO - 'title': 'talos-linux64-ix-021', 05:10:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:10:57 INFO - 'use_talos_json': True, 05:10:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:10:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:10:57 INFO - 'work_dir': 'build'} 05:10:57 INFO - ##### 05:10:57 INFO - ##### Running clobber step. 05:10:57 INFO - ##### 05:10:57 INFO - Running pre-action listener: _resource_record_pre_action 05:10:57 INFO - Running main action method: clobber 05:10:57 INFO - rmtree: /builds/slave/test/build 05:10:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:10:57 INFO - Running post-action listener: _resource_record_post_action 05:10:57 INFO - ##### 05:10:57 INFO - ##### Running read-buildbot-config step. 05:10:57 INFO - ##### 05:10:57 INFO - Running pre-action listener: _resource_record_pre_action 05:10:57 INFO - Running main action method: read_buildbot_config 05:10:57 INFO - Using buildbot properties: 05:10:57 INFO - { 05:10:57 INFO - "project": "", 05:10:57 INFO - "product": "firefox", 05:10:57 INFO - "script_repo_revision": "production", 05:10:57 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 05:10:57 INFO - "repository": "", 05:10:57 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 05:10:57 INFO - "buildid": "20160601021650", 05:10:57 INFO - "pgo_build": "True", 05:10:57 INFO - "basedir": "/builds/slave/test", 05:10:57 INFO - "buildnumber": 322, 05:10:57 INFO - "slavename": "talos-linux64-ix-021", 05:10:57 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:10:57 INFO - "platform": "ubuntu64_hw", 05:10:57 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 05:10:57 INFO - "branch": "mozilla-aurora", 05:10:57 INFO - "repo_path": "releases/mozilla-aurora", 05:10:57 INFO - "revision": "b73cfa00dab309c8b999550363df0c0456128b90", 05:10:57 INFO - "stage_platform": "linux64-pgo", 05:10:57 INFO - "builduid": "1548571e00b64466a2baddee8cc67cdc", 05:10:57 INFO - "slavebuilddir": "test" 05:10:57 INFO - } 05:10:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/ERN1Yn6ITHyyQBFQTaiReg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 05:10:57 INFO - Running post-action listener: _resource_record_post_action 05:10:57 INFO - ##### 05:10:57 INFO - ##### Running download-and-extract step. 05:10:57 INFO - ##### 05:10:57 INFO - Running pre-action listener: _resource_record_pre_action 05:10:57 INFO - Running main action method: download_and_extract 05:10:57 INFO - mkdir: /builds/slave/test/build/tests 05:10:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:57 INFO - https://queue.taskcluster.net/v1/task/ERN1Yn6ITHyyQBFQTaiReg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:10:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ERN1Yn6ITHyyQBFQTaiReg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 05:10:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ERN1Yn6ITHyyQBFQTaiReg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 05:10:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ERN1Yn6ITHyyQBFQTaiReg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 05:10:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ERN1Yn6ITHyyQBFQTaiReg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:10:58 INFO - Downloaded 1361 bytes. 05:10:58 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 05:10:58 INFO - Using the following test package requirements: 05:10:58 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 05:10:58 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 05:10:58 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 05:10:58 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 05:10:58 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 05:10:58 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 05:10:58 INFO - u'jsshell-linux-x86_64.zip'], 05:10:58 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 05:10:58 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 05:10:58 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 05:10:58 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 05:10:58 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 05:10:58 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 05:10:58 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 05:10:58 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 05:10:58 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 05:10:58 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 05:10:58 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 05:10:58 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:10:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:58 INFO - https://queue.taskcluster.net/v1/task/ERN1Yn6ITHyyQBFQTaiReg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:10:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ERN1Yn6ITHyyQBFQTaiReg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 05:10:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ERN1Yn6ITHyyQBFQTaiReg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 05:10:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ERN1Yn6ITHyyQBFQTaiReg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 05:10:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ERN1Yn6ITHyyQBFQTaiReg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:11:00 INFO - Downloaded 24174964 bytes. 05:11:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:11:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:11:01 INFO - Return code: 0 05:11:01 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:11:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:01 INFO - https://queue.taskcluster.net/v1/task/ERN1Yn6ITHyyQBFQTaiReg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:11:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ERN1Yn6ITHyyQBFQTaiReg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 05:11:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ERN1Yn6ITHyyQBFQTaiReg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 05:11:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ERN1Yn6ITHyyQBFQTaiReg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 05:11:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ERN1Yn6ITHyyQBFQTaiReg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:11:03 INFO - Downloaded 24174964 bytes. 05:11:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:11:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:11:05 INFO - Return code: 0 05:11:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:05 INFO - https://queue.taskcluster.net/v1/task/ERN1Yn6ITHyyQBFQTaiReg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:11:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ERN1Yn6ITHyyQBFQTaiReg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 05:11:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ERN1Yn6ITHyyQBFQTaiReg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 05:11:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ERN1Yn6ITHyyQBFQTaiReg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 05:11:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ERN1Yn6ITHyyQBFQTaiReg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:11:06 INFO - Downloaded 10840145 bytes. 05:11:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:11:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:11:07 INFO - Return code: 0 05:11:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:07 INFO - https://queue.taskcluster.net/v1/task/ERN1Yn6ITHyyQBFQTaiReg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:11:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ERN1Yn6ITHyyQBFQTaiReg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 05:11:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ERN1Yn6ITHyyQBFQTaiReg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 05:11:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ERN1Yn6ITHyyQBFQTaiReg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 05:11:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ERN1Yn6ITHyyQBFQTaiReg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:11:08 INFO - Downloaded 62804746 bytes. 05:11:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ERN1Yn6ITHyyQBFQTaiReg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 05:11:08 INFO - mkdir: /builds/slave/test/properties 05:11:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:11:08 INFO - Writing to file /builds/slave/test/properties/build_url 05:11:08 INFO - Contents: 05:11:08 INFO - build_url:https://queue.taskcluster.net/v1/task/ERN1Yn6ITHyyQBFQTaiReg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 05:11:09 INFO - Running post-action listener: _resource_record_post_action 05:11:09 INFO - Running post-action listener: set_extra_try_arguments 05:11:09 INFO - ##### 05:11:09 INFO - ##### Running populate-webroot step. 05:11:09 INFO - ##### 05:11:09 INFO - Running pre-action listener: _resource_record_pre_action 05:11:09 INFO - Running main action method: populate_webroot 05:11:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:11:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:11:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:11:09 INFO - '--tppagecycles', 05:11:09 INFO - '7'], 05:11:09 INFO - 'tests': ['tsvgm']}}, 05:11:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:11:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:11:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:11:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:11:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:11:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:11:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:09 INFO - 'talos_options': ['--disable-e10s'], 05:11:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:11:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:11:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:09 INFO - 'talos_options': ['--disable-e10s'], 05:11:09 INFO - 'tests': ['damp', 'tps']}, 05:11:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:09 INFO - 'tests': ['damp', 'tps']}, 05:11:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:11:09 INFO - 'tests': ['dromaeo_dom']}, 05:11:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:11:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:11:09 INFO - 'tests': ['a11yr', 05:11:09 INFO - 'ts_paint', 05:11:09 INFO - 'tpaint', 05:11:09 INFO - 'sessionrestore', 05:11:09 INFO - 'sessionrestore_no_auto_restore', 05:11:09 INFO - 'tabpaint']}, 05:11:09 INFO - 'other-e10s': {'tests': ['a11yr', 05:11:09 INFO - 'ts_paint', 05:11:09 INFO - 'tpaint', 05:11:09 INFO - 'sessionrestore', 05:11:09 INFO - 'sessionrestore_no_auto_restore', 05:11:09 INFO - 'tabpaint']}, 05:11:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:11:09 INFO - 'ts_paint', 05:11:09 INFO - 'tpaint', 05:11:09 INFO - 'sessionrestore', 05:11:09 INFO - 'sessionrestore_no_auto_restore', 05:11:09 INFO - 'tabpaint']}, 05:11:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:11:09 INFO - 'ts_paint', 05:11:09 INFO - 'tpaint', 05:11:09 INFO - 'sessionrestore', 05:11:09 INFO - 'sessionrestore_no_auto_restore', 05:11:09 INFO - 'tabpaint']}, 05:11:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:11:09 INFO - 'tests': ['a11yr', 05:11:09 INFO - 'ts_paint', 05:11:09 INFO - 'tpaint', 05:11:09 INFO - 'sessionrestore', 05:11:09 INFO - 'sessionrestore_no_auto_restore', 05:11:09 INFO - 'tabpaint']}, 05:11:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:11:09 INFO - 'tests': ['a11yr', 05:11:09 INFO - 'ts_paint', 05:11:09 INFO - 'tpaint', 05:11:09 INFO - 'sessionrestore', 05:11:09 INFO - 'sessionrestore_no_auto_restore', 05:11:09 INFO - 'tabpaint']}, 05:11:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:11:09 INFO - 'tests': ['tsvgx', 05:11:09 INFO - 'tsvgr_opacity', 05:11:09 INFO - 'tart', 05:11:09 INFO - 'tscrollx', 05:11:09 INFO - 'cart']}, 05:11:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:11:09 INFO - 'tsvgr_opacity', 05:11:09 INFO - 'tart', 05:11:09 INFO - 'tscrollx', 05:11:09 INFO - 'cart']}, 05:11:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:09 INFO - 'talos_options': ['--disable-e10s'], 05:11:09 INFO - 'tests': ['tp5o']}, 05:11:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:09 INFO - 'tests': ['tp5o']}, 05:11:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:09 INFO - 'talos_options': ['--disable-e10s', 05:11:09 INFO - '--xperf_path', 05:11:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:11:09 INFO - 'tests': ['tp5n']}, 05:11:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:09 INFO - 'talos_options': ['--xperf_path', 05:11:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:11:09 INFO - 'tests': ['tp5n']}}, 05:11:09 INFO - 'talos.zip': {'path': '', 05:11:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:11:09 INFO - Running post-action listener: _resource_record_post_action 05:11:09 INFO - ##### 05:11:09 INFO - ##### Running create-virtualenv step. 05:11:09 INFO - ##### 05:11:09 INFO - Running pre-action listener: _resource_record_pre_action 05:11:09 INFO - Running main action method: create_virtualenv 05:11:09 INFO - Creating virtualenv /builds/slave/test/build/venv 05:11:09 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:11:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:11:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:11:09 INFO - Using real prefix '/usr' 05:11:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:11:10 INFO - Installing distribute.............................................................................................................................................................................................done. 05:11:12 INFO - Installing pip.................done. 05:11:12 INFO - Return code: 0 05:11:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:11:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1726c98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b565a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be5410>, '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 0x2be6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be67a0>, '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': 'df17445c3590ff7897617a0e00000225-1464783055.605947-1892751329', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:11:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:11:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:11:12 INFO - Using env: {'DISPLAY': ':0', 05:11:12 INFO - 'HOME': '/home/cltbld', 05:11:12 INFO - 'LANG': 'en_US.UTF-8', 05:11:12 INFO - 'LANGUAGE': 'en_US:en', 05:11:12 INFO - 'LOGNAME': 'cltbld', 05:11:12 INFO - 'MAIL': '/var/mail/cltbld', 05:11:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:12 INFO - 'MOZ_NO_REMOTE': '1', 05:11:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:12 INFO - 'NO_EM_RESTART': '1', 05:11:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:12 INFO - 'PWD': '/builds/slave/test', 05:11:12 INFO - 'SHELL': '/bin/bash', 05:11:12 INFO - 'SHLVL': '1', 05:11:12 INFO - 'TERM': 'linux', 05:11:12 INFO - 'TMOUT': '86400', 05:11:12 INFO - 'USER': 'cltbld', 05:11:12 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1464783055.605947-1892751329', 05:11:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:12 INFO - '_': '/tools/buildbot/bin/python'} 05:11:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:12 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:11:12 INFO - Cleaning up... 05:11:12 INFO - Return code: 0 05:11:12 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:11:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1726c98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b565a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be5410>, '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 0x2be6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be67a0>, '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': 'df17445c3590ff7897617a0e00000225-1464783055.605947-1892751329', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:11:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:11:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:11:12 INFO - Using env: {'DISPLAY': ':0', 05:11:12 INFO - 'HOME': '/home/cltbld', 05:11:12 INFO - 'LANG': 'en_US.UTF-8', 05:11:12 INFO - 'LANGUAGE': 'en_US:en', 05:11:12 INFO - 'LOGNAME': 'cltbld', 05:11:12 INFO - 'MAIL': '/var/mail/cltbld', 05:11:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:12 INFO - 'MOZ_NO_REMOTE': '1', 05:11:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:12 INFO - 'NO_EM_RESTART': '1', 05:11:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:12 INFO - 'PWD': '/builds/slave/test', 05:11:12 INFO - 'SHELL': '/bin/bash', 05:11:12 INFO - 'SHLVL': '1', 05:11:12 INFO - 'TERM': 'linux', 05:11:12 INFO - 'TMOUT': '86400', 05:11:12 INFO - 'USER': 'cltbld', 05:11:12 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1464783055.605947-1892751329', 05:11:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:12 INFO - '_': '/tools/buildbot/bin/python'} 05:11:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:12 INFO - Downloading/unpacking psutil>=0.7.1 05:11:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:11:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:11:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:11:14 INFO - Installing collected packages: psutil 05:11:14 INFO - Running setup.py install for psutil 05:11:14 INFO - building 'psutil._psutil_linux' extension 05:11:14 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:11:14 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:11:14 INFO - building 'psutil._psutil_posix' extension 05:11:14 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:11:15 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:11:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:11:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:11:15 INFO - Successfully installed psutil 05:11:15 INFO - Cleaning up... 05:11:15 INFO - Return code: 0 05:11:15 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:11: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')]} 05:11:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11: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')]} 05:11:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1726c98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b565a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be5410>, '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 0x2be6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be67a0>, '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': 'df17445c3590ff7897617a0e00000225-1464783055.605947-1892751329', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:11:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:11:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:11:15 INFO - Using env: {'DISPLAY': ':0', 05:11:15 INFO - 'HOME': '/home/cltbld', 05:11:15 INFO - 'LANG': 'en_US.UTF-8', 05:11:15 INFO - 'LANGUAGE': 'en_US:en', 05:11:15 INFO - 'LOGNAME': 'cltbld', 05:11:15 INFO - 'MAIL': '/var/mail/cltbld', 05:11:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:15 INFO - 'MOZ_NO_REMOTE': '1', 05:11:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:15 INFO - 'NO_EM_RESTART': '1', 05:11:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:15 INFO - 'PWD': '/builds/slave/test', 05:11:15 INFO - 'SHELL': '/bin/bash', 05:11:15 INFO - 'SHLVL': '1', 05:11:15 INFO - 'TERM': 'linux', 05:11:15 INFO - 'TMOUT': '86400', 05:11:15 INFO - 'USER': 'cltbld', 05:11:15 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1464783055.605947-1892751329', 05:11:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:15 INFO - '_': '/tools/buildbot/bin/python'} 05:11:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:15 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:11:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:17 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:11:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:11:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:11:17 INFO - Installing collected packages: mozsystemmonitor 05:11:17 INFO - Running setup.py install for mozsystemmonitor 05:11:17 INFO - Successfully installed mozsystemmonitor 05:11:17 INFO - Cleaning up... 05:11:17 INFO - Return code: 0 05:11:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:11:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1726c98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b565a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be5410>, '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 0x2be6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be67a0>, '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': 'df17445c3590ff7897617a0e00000225-1464783055.605947-1892751329', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:11:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:11:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:11:17 INFO - Using env: {'DISPLAY': ':0', 05:11:17 INFO - 'HOME': '/home/cltbld', 05:11:17 INFO - 'LANG': 'en_US.UTF-8', 05:11:17 INFO - 'LANGUAGE': 'en_US:en', 05:11:17 INFO - 'LOGNAME': 'cltbld', 05:11:17 INFO - 'MAIL': '/var/mail/cltbld', 05:11:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:17 INFO - 'MOZ_NO_REMOTE': '1', 05:11:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:17 INFO - 'NO_EM_RESTART': '1', 05:11:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:17 INFO - 'PWD': '/builds/slave/test', 05:11:17 INFO - 'SHELL': '/bin/bash', 05:11:17 INFO - 'SHLVL': '1', 05:11:17 INFO - 'TERM': 'linux', 05:11:17 INFO - 'TMOUT': '86400', 05:11:17 INFO - 'USER': 'cltbld', 05:11:17 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1464783055.605947-1892751329', 05:11:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:17 INFO - '_': '/tools/buildbot/bin/python'} 05:11:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:17 INFO - Downloading/unpacking blobuploader==1.2.4 05:11:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:19 INFO - Downloading blobuploader-1.2.4.tar.gz 05:11:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:11:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:11:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:11:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:11:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:20 INFO - Downloading docopt-0.6.1.tar.gz 05:11:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:11:20 INFO - Installing collected packages: blobuploader, requests, docopt 05:11:20 INFO - Running setup.py install for blobuploader 05:11:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:11:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:11:20 INFO - Running setup.py install for requests 05:11:20 INFO - Running setup.py install for docopt 05:11:20 INFO - Successfully installed blobuploader requests docopt 05:11:20 INFO - Cleaning up... 05:11:21 INFO - Return code: 0 05:11:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:11:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1726c98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b565a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be5410>, '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 0x2be6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be67a0>, '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': 'df17445c3590ff7897617a0e00000225-1464783055.605947-1892751329', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:11:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:11:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:11:21 INFO - Using env: {'DISPLAY': ':0', 05:11:21 INFO - 'HOME': '/home/cltbld', 05:11:21 INFO - 'LANG': 'en_US.UTF-8', 05:11:21 INFO - 'LANGUAGE': 'en_US:en', 05:11:21 INFO - 'LOGNAME': 'cltbld', 05:11:21 INFO - 'MAIL': '/var/mail/cltbld', 05:11:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:21 INFO - 'MOZ_NO_REMOTE': '1', 05:11:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:21 INFO - 'NO_EM_RESTART': '1', 05:11:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:21 INFO - 'PWD': '/builds/slave/test', 05:11:21 INFO - 'SHELL': '/bin/bash', 05:11:21 INFO - 'SHLVL': '1', 05:11:21 INFO - 'TERM': 'linux', 05:11:21 INFO - 'TMOUT': '86400', 05:11:21 INFO - 'USER': 'cltbld', 05:11:21 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1464783055.605947-1892751329', 05:11:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:21 INFO - '_': '/tools/buildbot/bin/python'} 05:11:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:11:21 INFO - Running setup.py (path:/tmp/pip-CeKoZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:11:21 INFO - Running setup.py (path:/tmp/pip-LYIPya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:11:21 INFO - Running setup.py (path:/tmp/pip-t6KXi3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:11:21 INFO - Running setup.py (path:/tmp/pip-A86CII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:11:21 INFO - Running setup.py (path:/tmp/pip-deOJFx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:11:21 INFO - Running setup.py (path:/tmp/pip-lhrcZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:11:21 INFO - Running setup.py (path:/tmp/pip-wOQ31q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:11:21 INFO - Running setup.py (path:/tmp/pip-GJAqc7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:11:21 INFO - Running setup.py (path:/tmp/pip-zRciA_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:11:21 INFO - Running setup.py (path:/tmp/pip-gZ55W5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:11:21 INFO - Running setup.py (path:/tmp/pip-8dJ0ly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:11:22 INFO - Running setup.py (path:/tmp/pip-l7cQk2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:11:22 INFO - Running setup.py (path:/tmp/pip-AhjkbK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:11:22 INFO - Running setup.py (path:/tmp/pip-hUSVBE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:11:22 INFO - Running setup.py (path:/tmp/pip-s2tW5g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:11:22 INFO - Running setup.py (path:/tmp/pip-7oUsRh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:11:22 INFO - Running setup.py (path:/tmp/pip-YXRpEk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:11:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:11:22 INFO - Running setup.py install for manifestparser 05:11:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:11:22 INFO - Running setup.py install for mozcrash 05:11:22 INFO - Running setup.py install for mozdebug 05:11:22 INFO - Running setup.py install for mozdevice 05:11:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:11:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:11:22 INFO - Running setup.py install for mozfile 05:11:22 INFO - Running setup.py install for mozhttpd 05:11:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:11:23 INFO - Running setup.py install for mozinfo 05:11:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:11:23 INFO - Running setup.py install for mozInstall 05:11:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:11:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:11:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:11:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:11:23 INFO - Running setup.py install for mozleak 05:11:23 INFO - Running setup.py install for mozlog 05:11:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:11:23 INFO - Running setup.py install for moznetwork 05:11:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:11:23 INFO - Running setup.py install for mozprocess 05:11:23 INFO - Running setup.py install for mozprofile 05:11:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:11:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:11:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:11:23 INFO - Running setup.py install for mozrunner 05:11:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:11:23 INFO - Running setup.py install for mozscreenshot 05:11:24 INFO - Running setup.py install for moztest 05:11:24 INFO - Running setup.py install for mozversion 05:11:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:11:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:11:24 INFO - Cleaning up... 05:11:24 INFO - Return code: 0 05:11:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:11:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1726c98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b565a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be5410>, '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 0x2be6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be67a0>, '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': 'df17445c3590ff7897617a0e00000225-1464783055.605947-1892751329', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:11:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:11:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:11:24 INFO - Using env: {'DISPLAY': ':0', 05:11:24 INFO - 'HOME': '/home/cltbld', 05:11:24 INFO - 'LANG': 'en_US.UTF-8', 05:11:24 INFO - 'LANGUAGE': 'en_US:en', 05:11:24 INFO - 'LOGNAME': 'cltbld', 05:11:24 INFO - 'MAIL': '/var/mail/cltbld', 05:11:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:24 INFO - 'MOZ_NO_REMOTE': '1', 05:11:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:24 INFO - 'NO_EM_RESTART': '1', 05:11:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:24 INFO - 'PWD': '/builds/slave/test', 05:11:24 INFO - 'SHELL': '/bin/bash', 05:11:24 INFO - 'SHLVL': '1', 05:11:24 INFO - 'TERM': 'linux', 05:11:24 INFO - 'TMOUT': '86400', 05:11:24 INFO - 'USER': 'cltbld', 05:11:24 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1464783055.605947-1892751329', 05:11:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:24 INFO - '_': '/tools/buildbot/bin/python'} 05:11:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:11:24 INFO - Running setup.py (path:/tmp/pip-3OFmxU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:11:24 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:11:24 INFO - Running setup.py (path:/tmp/pip-XMRKU4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:11:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:11:24 INFO - Running setup.py (path:/tmp/pip-ibBF9i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:11:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:11:24 INFO - Running setup.py (path:/tmp/pip-0WpieY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:11:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:11:24 INFO - Running setup.py (path:/tmp/pip-hP7tCC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:11:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:11:24 INFO - Running setup.py (path:/tmp/pip-VeS8IE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:11:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:11:24 INFO - Running setup.py (path:/tmp/pip-3CApbU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:11:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:11:24 INFO - Running setup.py (path:/tmp/pip-hdPudI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:11:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:11:25 INFO - Running setup.py (path:/tmp/pip-CMtd7C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:11:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:11:25 INFO - Running setup.py (path:/tmp/pip-PRCQKV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:11:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:11:25 INFO - Running setup.py (path:/tmp/pip-r33TLy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:11:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:11:25 INFO - Running setup.py (path:/tmp/pip-ZvxvlA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:11:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:11:25 INFO - Running setup.py (path:/tmp/pip-wpbVfR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:11:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:11:25 INFO - Running setup.py (path:/tmp/pip-akixaj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:11:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:11:25 INFO - Running setup.py (path:/tmp/pip-ton5KX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:11:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:11:25 INFO - Running setup.py (path:/tmp/pip-U9FkvX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:11:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:11:25 INFO - Running setup.py (path:/tmp/pip-7qcBZ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:11:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:11:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:11:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:11:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:11:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:11:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:11:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:11:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:27 INFO - Downloading blessings-1.6.tar.gz 05:11:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:11:27 INFO - Installing collected packages: blessings 05:11:27 INFO - Running setup.py install for blessings 05:11:27 INFO - Successfully installed blessings 05:11:27 INFO - Cleaning up... 05:11:27 INFO - Return code: 0 05:11:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:11:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:11:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:11:28 INFO - Reading from file tmpfile_stdout 05:11:28 INFO - Current package versions: 05:11:28 INFO - argparse == 1.2.1 05:11:28 INFO - blessings == 1.6 05:11:28 INFO - blobuploader == 1.2.4 05:11:28 INFO - docopt == 0.6.1 05:11:28 INFO - manifestparser == 1.1 05:11:28 INFO - mozInstall == 1.12 05:11:28 INFO - mozcrash == 0.17 05:11:28 INFO - mozdebug == 0.1 05:11:28 INFO - mozdevice == 0.48 05:11:28 INFO - mozfile == 1.2 05:11:28 INFO - mozhttpd == 0.7 05:11:28 INFO - mozinfo == 0.9 05:11:28 INFO - mozleak == 0.1 05:11:28 INFO - mozlog == 3.1 05:11:28 INFO - moznetwork == 0.27 05:11:28 INFO - mozprocess == 0.22 05:11:28 INFO - mozprofile == 0.28 05:11:28 INFO - mozrunner == 6.11 05:11:28 INFO - mozscreenshot == 0.1 05:11:28 INFO - mozsystemmonitor == 0.0 05:11:28 INFO - moztest == 0.7 05:11:28 INFO - mozversion == 1.4 05:11:28 INFO - psutil == 3.1.1 05:11:28 INFO - requests == 1.2.3 05:11:28 INFO - wsgiref == 0.1.2 05:11:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:11:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1726c98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b565a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be5410>, '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 0x2be6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be67a0>, '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': 'df17445c3590ff7897617a0e00000225-1464783055.605947-1892751329', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:11:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:11:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:11:28 INFO - Using env: {'DISPLAY': ':0', 05:11:28 INFO - 'HOME': '/home/cltbld', 05:11:28 INFO - 'LANG': 'en_US.UTF-8', 05:11:28 INFO - 'LANGUAGE': 'en_US:en', 05:11:28 INFO - 'LOGNAME': 'cltbld', 05:11:28 INFO - 'MAIL': '/var/mail/cltbld', 05:11:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:28 INFO - 'MOZ_NO_REMOTE': '1', 05:11:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:28 INFO - 'NO_EM_RESTART': '1', 05:11:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:28 INFO - 'PWD': '/builds/slave/test', 05:11:28 INFO - 'SHELL': '/bin/bash', 05:11:28 INFO - 'SHLVL': '1', 05:11:28 INFO - 'TERM': 'linux', 05:11:28 INFO - 'TMOUT': '86400', 05:11:28 INFO - 'USER': 'cltbld', 05:11:28 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1464783055.605947-1892751329', 05:11:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:28 INFO - '_': '/tools/buildbot/bin/python'} 05:11:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:11:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:11:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:11:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:11:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:11:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:11:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:11:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:11:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:11:28 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:11:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:11:28 INFO - Cleaning up... 05:11:28 INFO - Return code: 0 05:11:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:11:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1726c98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b565a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be5410>, '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 0x2be6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be67a0>, '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': 'df17445c3590ff7897617a0e00000225-1464783055.605947-1892751329', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:11:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:11:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:11:28 INFO - Using env: {'DISPLAY': ':0', 05:11:28 INFO - 'HOME': '/home/cltbld', 05:11:28 INFO - 'LANG': 'en_US.UTF-8', 05:11:28 INFO - 'LANGUAGE': 'en_US:en', 05:11:28 INFO - 'LOGNAME': 'cltbld', 05:11:28 INFO - 'MAIL': '/var/mail/cltbld', 05:11:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:28 INFO - 'MOZ_NO_REMOTE': '1', 05:11:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:28 INFO - 'NO_EM_RESTART': '1', 05:11:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:28 INFO - 'PWD': '/builds/slave/test', 05:11:28 INFO - 'SHELL': '/bin/bash', 05:11:28 INFO - 'SHLVL': '1', 05:11:28 INFO - 'TERM': 'linux', 05:11:28 INFO - 'TMOUT': '86400', 05:11:28 INFO - 'USER': 'cltbld', 05:11:28 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1464783055.605947-1892751329', 05:11:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:28 INFO - '_': '/tools/buildbot/bin/python'} 05:11:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:28 INFO - Downloading/unpacking jsonschema 05:11:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:11:30 INFO - Downloading/unpacking functools32 (from jsonschema) 05:11:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:30 INFO - Downloading functools32-3.2.3-2.tar.gz 05:11:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:11:30 INFO - warning: no files found matching '*.txt' 05:11:30 INFO - no previously-included directories found matching 'build' 05:11:30 INFO - no previously-included directories found matching 'dist' 05:11:30 INFO - no previously-included directories found matching '.git*' 05:11:30 INFO - Installing collected packages: jsonschema, functools32 05:11:30 INFO - Running setup.py install for functools32 05:11:30 INFO - warning: no files found matching '*.txt' 05:11:30 INFO - no previously-included directories found matching 'build' 05:11:30 INFO - no previously-included directories found matching 'dist' 05:11:30 INFO - no previously-included directories found matching '.git*' 05:11:30 INFO - Successfully installed jsonschema functools32 05:11:30 INFO - Cleaning up... 05:11:31 INFO - Return code: 0 05:11:31 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:11:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:31 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 0x7f1726c98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b565a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be5410>, '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 0x2be6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be67a0>, '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': 'df17445c3590ff7897617a0e00000225-1464783055.605947-1892751329', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:11:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:11:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:11:31 INFO - Using env: {'DISPLAY': ':0', 05:11:31 INFO - 'HOME': '/home/cltbld', 05:11:31 INFO - 'LANG': 'en_US.UTF-8', 05:11:31 INFO - 'LANGUAGE': 'en_US:en', 05:11:31 INFO - 'LOGNAME': 'cltbld', 05:11:31 INFO - 'MAIL': '/var/mail/cltbld', 05:11:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:31 INFO - 'MOZ_NO_REMOTE': '1', 05:11:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:31 INFO - 'NO_EM_RESTART': '1', 05:11:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:31 INFO - 'PWD': '/builds/slave/test', 05:11:31 INFO - 'SHELL': '/bin/bash', 05:11:31 INFO - 'SHLVL': '1', 05:11:31 INFO - 'TERM': 'linux', 05:11:31 INFO - 'TMOUT': '86400', 05:11:31 INFO - 'USER': 'cltbld', 05:11:31 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1464783055.605947-1892751329', 05:11:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:31 INFO - '_': '/tools/buildbot/bin/python'} 05:11:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:31 INFO - Downloading/unpacking flake8 05:11:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:33 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:11:33 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:11:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:33 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:11:33 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:11:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:33 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:11:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:11:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:11:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:11:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:11:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:11:33 INFO - no previously-included directories found matching 'docs/_build' 05:11:33 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:11:33 INFO - Running setup.py install for pep8 05:11:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:11:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:11:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:11:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:11:34 INFO - no previously-included directories found matching 'docs/_build' 05:11:34 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:11:34 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:11:34 INFO - Cleaning up... 05:11:34 INFO - Return code: 0 05:11:34 INFO - Running post-action listener: _resource_record_post_action 05:11:34 INFO - Running post-action listener: _start_resource_monitoring 05:11:34 INFO - Starting resource monitoring. 05:11:34 INFO - ##### 05:11:34 INFO - ##### Running install step. 05:11:34 INFO - ##### 05:11:34 INFO - Running pre-action listener: _resource_record_pre_action 05:11:34 INFO - Running main action method: install 05:11:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:11:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:11:34 INFO - Reading from file tmpfile_stdout 05:11:34 INFO - Detecting whether we're running mozinstall >=1.0... 05:11:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:11:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:11:34 INFO - Reading from file tmpfile_stdout 05:11:34 INFO - Output received: 05:11:34 INFO - Usage: mozinstall [options] installer 05:11:34 INFO - Options: 05:11:34 INFO - -h, --help show this help message and exit 05:11:34 INFO - -d DEST, --destination=DEST 05:11:34 INFO - Directory to install application into. [default: 05:11:34 INFO - "/builds/slave/test"] 05:11:34 INFO - --app=APP Application being installed. [default: firefox] 05:11:34 INFO - mkdir: /builds/slave/test/build/application 05:11:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:11:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:11:50 INFO - Reading from file tmpfile_stdout 05:11:50 INFO - Output received: 05:11:50 INFO - /builds/slave/test/build/application/firefox/firefox 05:11:50 INFO - Running post-action listener: _resource_record_post_action 05:11:50 INFO - ##### 05:11:50 INFO - ##### Running run-tests step. 05:11:50 INFO - ##### 05:11:50 INFO - Running pre-action listener: _resource_record_pre_action 05:11:50 INFO - Running main action method: run_tests 05:11:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:11:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:11:50 INFO - Python 2.7.3 05:11:50 INFO - Return code: 0 05:11:50 INFO - grabbing minidump binary from tooltool 05:11: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')]} 05:11:50 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 0x2be5410>, '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 0x2be6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be67a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:11:50 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:11:50 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:11:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:11:50 INFO - Return code: 0 05:11:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:11:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:11:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:11:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:11:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:11:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:11:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:11:51 INFO - Return code: 0 05:11:51 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/ERN1Yn6ITHyyQBFQTaiReg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 05:11:51 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/ERN1Yn6ITHyyQBFQTaiReg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --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 05:11:51 INFO - Using env: {'DISPLAY': ':0', 05:11:51 INFO - 'HOME': '/home/cltbld', 05:11:51 INFO - 'LANG': 'en_US.UTF-8', 05:11:51 INFO - 'LANGUAGE': 'en_US:en', 05:11:51 INFO - 'LOGNAME': 'cltbld', 05:11:51 INFO - 'MAIL': '/var/mail/cltbld', 05:11:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:11:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:11:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:51 INFO - 'MOZ_NO_REMOTE': '1', 05:11:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:11:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:51 INFO - 'NO_EM_RESTART': '1', 05:11:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:51 INFO - 'PWD': '/builds/slave/test', 05:11:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:11:51 INFO - 'SHELL': '/bin/bash', 05:11:51 INFO - 'SHLVL': '1', 05:11:51 INFO - 'TERM': 'linux', 05:11:51 INFO - 'TMOUT': '86400', 05:11:51 INFO - 'USER': 'cltbld', 05:11:51 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1464783055.605947-1892751329', 05:11:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:51 INFO - '_': '/tools/buildbot/bin/python'} 05:11:51 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/ERN1Yn6ITHyyQBFQTaiReg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 05:11:51 INFO - mozversion application_buildid: 20160601021650 05:11:51 INFO - mozversion application_changeset: b73cfa00dab309c8b999550363df0c0456128b90 05:11:51 INFO - mozversion application_display_name: FirefoxDeveloperEdition 05:11:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:11:51 INFO - mozversion application_name: Firefox 05:11:51 INFO - mozversion application_remotingname: firefox-dev 05:11:51 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:11:51 INFO - mozversion application_vendor: Mozilla 05:11:51 INFO - mozversion application_version: 48.0a2 05:11:51 INFO - mozversion platform_buildid: 20160601021650 05:11:51 INFO - mozversion platform_changeset: b73cfa00dab309c8b999550363df0c0456128b90 05:11:51 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:11:51 INFO - mozversion platform_version: 48.0a2 05:11:51 INFO - using testdate: 1464783111 05:11:51 INFO - actual date: 1464783111 05:11:51 INFO - starting webserver on 'localhost:41585' 05:11:51 INFO - SUITE-START | Running 2 tests 05:11:51 INFO - TEST-START | dromaeo_css 05:11:51 INFO - operating with platform_type : linux_ 05:11:51 INFO - Initialising browser for dromaeo_css test... 05:11:51 INFO - TEST-INFO | started process 23977 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQIm4xA/profile http://localhost:41585/getInfo.html) 05:11:55 INFO - PROCESS | 23977 | 05:11:55 INFO - PROCESS | 23977 | (process:24058): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:11:56 INFO - PROCESS | 23977 | __metrics Screen width/height:1600/1200 05:11:56 INFO - PROCESS | 23977 | colorDepth:24 05:11:56 INFO - PROCESS | 23977 | Browser inner width/height: 1024/697 05:11:56 INFO - PROCESS | 23977 | __metrics 05:11:57 ERROR - PROCESS | 23977 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 05:11:58 INFO - TEST-INFO | 23977: exit 0 05:11:58 INFO - Browser initialized. 05:11:58 INFO - Running cycle 1/1 for dromaeo_css test... 05:11:58 INFO - TEST-INFO | started process 24110 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQIm4xA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:11:59 INFO - PROCESS | 24110 | 05:11:59 INFO - PROCESS | 24110 | (process:24178): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:12:09 INFO - PROCESS | 24110 | RSS: Main: 152449024 05:12:09 INFO - PROCESS | 24110 | 05:12:59 INFO - PROCESS | 24110 | 1464783179450 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:15:06 INFO - PROCESS | 24110 | Cycle 1(1): loaded http://localhost:41585/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41585/tests/dromaeo/cssquery-ext.html) 05:15:07 INFO - PROCESS | 24110 | RSS: Main: 155766784 05:15:07 INFO - PROCESS | 24110 | 05:18:09 INFO - PROCESS | 24110 | Cycle 1(1): loaded http://localhost:41585/tests/dromaeo/cssquery-ext.html (next: http://localhost:41585/tests/dromaeo/cssquery-jquery.html) 05:18:10 INFO - PROCESS | 24110 | RSS: Main: 153636864 05:18:10 INFO - PROCESS | 24110 | 05:21:11 INFO - PROCESS | 24110 | Cycle 1(1): loaded http://localhost:41585/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41585/tests/dromaeo/cssquery-mootools.html) 05:21:12 INFO - PROCESS | 24110 | RSS: Main: 152981504 05:21:12 INFO - PROCESS | 24110 | 05:24:14 INFO - PROCESS | 24110 | Cycle 1(1): loaded http://localhost:41585/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41585/tests/dromaeo/cssquery-prototype.html) 05:24:14 INFO - PROCESS | 24110 | RSS: Main: 152932352 05:24:14 INFO - PROCESS | 24110 | 05:27:17 INFO - PROCESS | 24110 | Cycle 1(1): loaded http://localhost:41585/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41585/tests/dromaeo/cssquery-yui.html) 05:27:17 INFO - PROCESS | 24110 | RSS: Main: 154673152 05:27:17 INFO - PROCESS | 24110 | 05:30:19 INFO - PROCESS | 24110 | Cycle 1(1): loaded http://localhost:41585/tests/dromaeo/cssquery-yui.html (next: http://localhost:41585/tests/dromaeo/cssquery-dojo.html) 05:30:20 INFO - PROCESS | 24110 | RSS: Main: 156241920 05:30:20 INFO - PROCESS | 24110 | 05:30:20 INFO - PROCESS | 24110 | __start_tp_report 05:30:20 INFO - PROCESS | 24110 | _x_x_mozilla_page_load 05:30:20 INFO - PROCESS | 24110 | _x_x_mozilla_page_load_details 05:30:20 INFO - PROCESS | 24110 | |i|pagename|runs| 05:30:20 INFO - PROCESS | 24110 | |0;dojo.html;3324.8670053197875;3357.949630755538;3360.8655653773844;3386.2888793353395;3405.1997780521574;5346.27825243592;5383.784648614051;5391.946080539194;5396.028714831334;5398.946010539898;5365.087935051041;5377.327834020747;5398.865028374283;5408.4050754416985;5445.319335083114;4847.563719265274;4893.8776530586665;4962.60299176065;4975.253711943201;5013.699178049311;4900.117978763821;5008.023435430093;5051.722155281458;5052.26742122392;5065.214891691794;4938.135826230413;4987.451380348159;5016.8996620067755;5083.440821509631;5084.9321642455125;4962.3548938638105;4968.975155124237;4973.602111831045;4985.277134815449;5011.123053465665;4896.60827133832;4935.383077115361;4946.653734238605;4963.826266080706;4969.204927211629;5144.768485418165;5288.153895376721;5352.571794256489;5365.302510673627;5369.5167434931045;5783.363829978741;5817.214676018725;5832.212651292064;5833.358330583633;5850.970745146247;5741.827745167651;5904.143899134644;5908.231929849135;5911.290645122613;5923.111533270001;5462.535684466825;5474.972625136888;5514.944850551483;5534.308211473566;5534.723263836792;5944.910826337608;5948.286205655262;5959.165716799652;5967.343592204854;5977.222961015127;5723.828285151452;5747.339056008529;5749.568782341257;5749.8275051748515;5757.568182386338;5808.651480911159;5839.854003649943;5844;5847.8245652630485;5851.063829787214;5804.187413762077;5808;5813.6221145625395;5818.272715910512;5822.534197264209;5694.829155125353;5759.395263497357;5789.971050144806;5811.070228763378;5814.040683287295;4443.711158774734;4449.866504004885;4454.354118652777;4459.063596644741;4481.014176881081;4014.197160567898;4025.496812898388;4033.778142202207;4060.4315395844606;4061.634452899253;5538.529225015919;5635.0702134147405;5716.256886604715;5725.541956643458;5739.339975902742;5700.543956483471;5727.140928860705;5728.369879313273;5736.741846616912;5770.855728606734;5609.046462101453;5624.943750562442;5628.887422251614;5631.662100273915;5636.830895073154;4967.627427942919;5028.949710502849;5060.924086138711;5076.720780357042;5083.669561478492;6029.6683682397015;6038.607490513103;6055.878882422327;6065.75736970525;6068.059450785136;5788.913166302593;5799.884002320015;5803.332616749128;5804.419558044162;5817.389174136655;6053.939460605337;6128.564234752123;6147.538934579835;6161.815145545641;6182.536309776875;5713.542916566582;5718.25662663851;5722.971385143048;5730.942690573041;5745.368009519033;5703.401142880104;5823.068309070529;5827.621204621686;5832.854178645568;5851.678157701367;5689.402612725769;5742.7702891883855;5747.453991870766;5774;5775.249217601685;5697.088465845445;5717.42825717425;5736.856578585569;5739.942600573941;5741.45456181662;5537.833864983896;5570.220169176399;5640.492355688008;5673.234113394639;5675.375708671961;5656.85857853557;5671.234383358194;5673.574481913791;5679.801206957736;5737.139429085503;5527.39198688152;5558.249636299048;5572.192032155396;5581.553475722014;5609.102543593169 05:30:20 INFO - PROCESS | 24110 | |1;ext.html;619.1950464396286;657.2441692054138;676.1818199978027;679.5481005131585;694.0491526608547;40587.39118913215;41106.58893411065;41239.587604123946;41318.58681413185;41387;44342.556574434246;44677.77661111698;44858.77570612151;45136.548634513645;45165.322520162226;8858.379913406048;8925;8986.101389860994;9014.729558113235;9042.457452552835;8981.820363592724;9051.637934482613;9072;9215;9326.393784404027;9289.767755806126;9324.11420915012;9356.111169438893;9371.109744574254;9392.436453812794;9203.079692030777;9216.124468175512;9339.392939458914;9354.95322523383;9359.906400936039;9171.816563668755;9245.907540924572;9257.028012058772;9315.534223288876;9345.20565751905;43466.130677386274;43589.346159807625;43659.34510982338;43908.560914390764;44028.119437611065;3809.6190380961684;4011.3180759270704;4027.0335119571387;4202.621764041251;4487.887802804923;33817.492737608954;34774.82612586946;34806.47790283148;34996.825015874754;36326.45510317347;4481.148581769454;4576.54234576543;4631.861044168681;4634.304854271886;4664.86005419838;220882;222119;222377;223160;223328;59778.40221597815;59948.700256498436;60420.09369859456;60442.093368598624;60462.69768651129;71255;73243;73465.26534734585;73894.26105738981;73911.63044184745;18654.53363665892;18764.24943002292;18850.71723924142;18869.52826179329;18888.244470221038;13992.09051411655;14013.649658758613;14034.789478157836;14046.508372206923;14064.226467544384;20666.276680316118;20684.276050338165;20923.26768563093;21002.264920727703;21635.459113521974;7733.342665873463;7743.7476259970945;7779;7971.242731940456;7996.760097197093;1170.4440390814295;1187.2994932989577;1193.671740271415;1241.2614494375832;1261.369315342329;34490;34525.82737086349;34550;34947;34969.47545786815;1238.646985609097;1264.8988080953502;1290.677330667333;1290.8580056193812;1300.2718477652545;17740.822591774177;17984;17989;18034.729479057823;18184.727229091575;494555;505331;954390;963603;1074042;66341;67215.32784672189;67474.32525674779;67475.32524674789;67561;1564.327339244136;1577.6213708710056;1584.67514159597;1589.2212815720213;1670.448751911866;34069.659303406646;35048;35173;35295.82352088223;35533;58586.4141358581;59328.11007834799;59453;59930.40069599248;59939.70030149821;466967;468799;469029;469916;470044;31675.841620791747;31866.840665796524;31929.8403507981;31976.6802331983;32556;53898;54073.72963135159;54726.726366369505;54891.45108548863;54961.725191373785;44559.55440445684;44626.77686611546;45036.32445513254;45520;45644.77177614091;42380.57619423766;44765.32852007288;45433.77283113563;45498.31752523649;46272.537274626826;39554;39891.80054099711;39986.400203997546;40317.1936561273;40554;34351.31297374088;34611.65388346185;34891.65108348986;34967.82516087403;35105.473417899266;30085;30306.787728491494;30345.696543034286;30413.695863041085;30598.235044124074 05:30:20 INFO - PROCESS | 24110 | |2;jquery.html;420.26873240561423;423.38186248077807;423.6187431311821;424.20461634435435;433.9587739164778;19594;20130.643972921796;20493.897530512364;20926.790732092675;21329.786702132973;20428.591428171465;20576.794232057677;21410;21437.67843482349;21465;5528.9494995950745;5750.166225897243;5843.79546715865;5852.531797456215;5860.765569377219;5762.798302059428;5810.477057064863;5828.388019257981;5875.324337701155;5877.617954832944;5685.744141513642;5766.1639062335935;5811.593188476808;5845.766169353242;5847.0352391855295;5640.915386269209;5670.809130082687;5680.147977803321;5685.346185188715;5721.199032135504;5125.641205115643;5238.1618940969265;5248.0553500369915;5262.158054711228;5265.605079619006;20870.37388878336;21845.890770546204;21871.12515499378;23290;24629;2460.5201985612634;2461.507698460297;2605.3226161198036;2736.411671490619;2970.4504666636526;10519.211059170593;10560.049595536362;10719.303245289031;10877.347359158475;13724.039317247796;1911.9617607647908;1943.2129987355145;2054.7739748627637;2088.853780235384;2165.058199683143;62924.37075629277;64414.67792661054;64605.353946460404;81388.59305703433;82382.58808705978;9057.411268267673;10666.253362264568;10841.566337346576;10952.288101273392;11123.55393798801;14974.475893343899;15067;15075.54773356801;15109.622259443602;15170.089794612139;8142.307903828241;8365.749027529062;8524.27543658796;8735.25750311218;8755.387122901337;8393.118722534167;8491.108433614505;8514.403991720521;8598.140185981352;8633.95683021581;5019.121653710659;5021.246812978009;5045.520675535891;5080.59355251579;5123.846284611468;2014.8441167950446;2074.792520747913;2086.196814226503;2093.4347726113865;2130.403487023636;1007.2345017786535;1059.3061544688242;1092.7541303206715;1126.2397881430002;1162.7558212775411;18998.905005474884;19491.22035118608;19694.90152549257;19900.402987910387;19997.800021999883;1036.4713995862164;1059.7774467361787;1069.3316677076828;1077.8006068877282;1141.2353723005606;10977.231593788358;11198.944005280084;11216.66350009501;11235.438228088562;11274.887251127384;496603;497714;498986;502317;532029.7383643859;62714;90243;94604.52697736467;96470;99004;986.4771671014374;1031.2471895516314;1079.32002838213;1116.4864162485185;1148.4717030166216;16180.595485112966;17455.30178792834;17650.470485885446;18113;18373.72439413383;38989.41515877208;40143.598564015156;40472.79763601281;40683.1863362737;41711.7914410426;56471;58417.415825842894;58512;59154.70422647859;59275.110873336074;8996.595153218252;9236.630534778533;9238;9298.907010929805;9321.347505674537;13437.328133593086;13467.12463689857;13485.528006519724;13725.931370343083;13835.239061851695;11436.313821170756;11542.538298468304;11573.768524629291;11692.47383867745;11880.821787673365;11619.535218591162;11639.359835209145;11674;12109.394530273627;12379.133460657667;12068.577599783965;12114.091443141624;12125.75748485043;12249.816252756038;12581.811272831097;8788.472691638523;8854.955725221333;8919.910800891908;8967.058458861986;9036.23192028685;9174.311926605398;12140.939295303468;12164.39178041112;12223.93888030554;12453 05:30:20 INFO - PROCESS | 24110 | |3;mootools.html;1577.3217516467919;1593.2909855114476;1830.4417152768408;1923.9807601923976;1932.0339830084965;7370.152432470268;7921.881171782428;8036.799080023003;8188.672453101876;8292.917070829297;8035.3169980551575;8083.676652933876;8094.109647938722;8103.473274237185;8133.186681331864;2357.893894774735;2361.740208577055;2375.8574485530835;2378.3102900158933;2379.048380647746;2275.8862056897174;2303.6199027160496;2394.2817154853474;2394.7485514021037;2395.8499920038394;2376.429656882353;2378.8453750506246;2384.880755962195;2450.191436825843;2453.9754602454013;2424.200013995395;2432.136591510015;2432.8418652787514;2437.390652336916;2468.5062987402594;2419.334682962182;2434.732179460258;2439.597466418039;2442.7312995570474;2445.376429010591;8330.541820199887;8368.623411946417;8372.204640559137;8378.413511054228;8388.119247478988;5155.9484405155845;5203.16749320107;5207.557357624606;5252.947470525284;5255.02781985334;3368.2253081791323;3390.9491357629654;3419.829008549563;3420.0765793235687;3437.1750779812664;1132.909367250618;1138.248755821154;1145.6906635208447;1147.7015975846257;1168.263993683982;11283.605073822459;11369.943150284278;11382.430878456044;11391.601293954755;11400.828987565194;4492.887677808081;4550.067236216634;4600.378948841931;4616.676832621684;4651.651126165551;9599.520023998772;9659.227261819038;9666;9669.371490853073;9685.854712179324;5199.948000520022;5225.242339860775;5240.528352448298;5251;5257.395399529027;4243.427137336482;4652.906941861143;4709.858704238878;4754.904901901942;4801.135795556764;3956.742811717229;3983.5618082010956;4021.678265738734;4025.1748391579654;4072.775997320176;1284.2487145020268;1287.9484820607258;1320.3662242123835;1321.5572783117764;1339.9263040532865;1038.6624347087077;1041.0474415909357;1060.3849767135043;1067.3595842494597;1071.8124328242527;5834.854128646818;5845.181674565564;5938.495227905676;6063.636181829104;6146.78486252979;442.0584155748236;444.02314907203635;444.3978409255477;448.74645825108706;1042.6663467690266;4037.9798101009305;4101.118259574206;4102.343625020042;4104.91790164195;4112.712110152321;9521.523923803783;9761.9023809761;9922.255830812574;9932.205423566098;9946.602135914627;9642.855357169648;9681.564329605184;9782.853257201148;9788.119069283655;9830.754231144136;7163.7134514619875;7208.747693830691;7325.670344834495;7503.7748867534065;7532.698692052257;5407.567394608343;5430.567877114507;5507.5593952484505;5516.14499752539;5547.1679248113105;8341.16588341161;8348.707795227137;8422.91577084246;8540.27407670355;8547.40168188221;8550.78623034429;8606.354523410644;8655.48067115975;8691.217790398894;8714.69498567547;6729.1252137221845;7040.5071644984355;7187.2453392393045;7354.96322518384;7445.813854653677;7718.459707820399;7744.612769361397;7766.223377662414;7793.571353575608;7808.258215469521;6741.764038258638;6950.756723514653;6983.1620205575655;6996.965015174892;7061.152661680631;6967.407770339375;6975.093237879043;6975.755848545276;7026.578405295699;7079.82300442493;6754.18949726036;6787.21946976104;6830.21452532965;6879.140107486564;6886.655667216519;4789.976050119727;4794.760261986957;4871.561559459666;4883.462819089827;4960.677555958851;4961.156603377507;4991.9500804991485;5004.649674522894;5059.974700126476;5078.5175408336145 05:30:20 INFO - PROCESS | 24110 | |4;prototype.html;327.552890304734;330.9768316217866;339.3230505142242;339.623018449521;340.87728417769586;6380.872382552347;6570.277269500357;6601.66991650418;6668.966655166723;6671.999999999994;6616.966915165417;6626.768063117792;6654.234763002256;6655.168103987002;6659.933400665992;4908.803647854082;4917.582005529534;4919.950800491985;4922.950770492303;4929.137400954836;4930.433000204968;4932.383452068491;4942.061008408391;4942.604591632661;4945.258211268302;4868.951310486903;4875.561199492045;4876.122297986361;4882.048000639877;4887.7311747853855;4666.416697912761;4841.346418233564;4884.51154884514;4886.926696099544;4895.241237608158;4183.602557757039;4192.224438478891;4197.034682023122;4199.97900010498;4201.957980420218;6281.434670879597;6300.936990630126;6303.527235457359;6305.716242769041;6315.96842015787;5657;5709.314882214119;5709.914351284734;5711.029125048752;5716.771329146829;6936.271691472373;6964.825879353057;6979;6979.755708550177;7031;4510.21071312519;4656.3946686930485;4692.0381321828945;4693.694909830884;4698.412698412699;7245.130584329914;7250.564966102051;7274.199838017814;7312.9396237546325;7327.9267207327775;4716;4759.547842954914;4763.2140696784645;4771.141194584939;4772.665913386099;4833.758312084382;4841.661083724105;4844.370231869905;4847.709137451764;4853.247746599282;5675;5691;5692.174634677948;5694.316681998187;5705.429457054262;6844.965775171092;6996.125484314461;7020.333068358498;7028.753993610199;7062.258462861429;1666.3334666133644;1677.337451706569;1685.9157042147845;1691.0023086379094;1692.4499537650313;1027.106417416852;1045.3936716704293;1060.81966065769;1073.7423018475665;1074.1031238915436;6660.467162626978;6868.484863635247;6909.654517274217;6910.44716422685;6944.756933507303;7277;7281.708731650675;7283;7303.598302093435;7311.488195826241;6876.140482439695;6884.759033433906;6896.551724137915;6903.344182302673;6907.067545881342;3871.825767840454;3875.903102422462;3917.5103112110987;3939.054626889526;3946.3488524393156;7673.34776544;7675.692972281158;7680.769576912701;7688.769336919901;7690.384769218449;7421.962890185515;7431.071116110486;7465.104187497426;7473.4021278297605;7474.514156579805;7604.80987975294;7667.156612772591;7678.5392876427595;7686.192949740309;7687.5387476751575;7058.153021637437;7262.055932728711;7269.745558905624;7279.5268307561955;7281.05346304977;7153.678084486315;7171.713131474683;7178.60517671533;7186.964065179641;7191.208967013729;7664.616769161408;7679.731209407644;7680.385569154342;7683.231676832272;7689.115751688628;4643.814247430065;4648.93026604608;4680.438347398334;4681.368015317888;4698.130845793539;7064.646767661699;7201.567905925661;7234.710611575478;7249.528780629243;7257.346838784323;6984.3364880336285;6998.230194678683;6999.475039371966;7005.929940700527;7032.472564557576;6988.440924726111;6991.545549539263;6992.300769922967;7014.123234595676;7019.929800701928;6857.657117144223;6890.552114112566;6902.792916212522;6912.827179320558;6917;6799.830004249933;7009.859802804018;7073.3987611053635;7075.858482830417;7093.858122837618;6766.492513061442;6924.549904256207;6925;6938.861222775416;6939.4795390346935 05:30:20 INFO - PROCESS | 24110 | |5;yui.html;816.4448175240838;861.3410740783298;913.4701872913711;918.3204428722745;924.2328867040358;13807.792883106762;13887;14160.433582656708;14409.71180576389;14589.781153282709;13416.195028298285;13453.260070696108;13458.990575706837;13460.326983650803;13488.460461581524;757.5530437042157;904;917.1424717888762;923.5290002098944;924.9583768730423;914.5792935249793;916.1937495004387;918.0910898210757;919.6873063158524;920.3649481857497;970.4129001953822;972.1348000279756;973.7419583810296;974.9463779492125;976.9120779129877;961.1493827962269;962.3263715399214;964.0455948610895;967.738710548155;970.4856426094182;716.4304378019435;717.125107369009;717.4834119433999;719.1083057009323;719.3238355945447;13985;13994.580162595139;14022.088564243291;14034.508792192326;14047.78928316076;15434.922825385913;15455.92272038644;15562;15692.215389230607;15731;12398.81401778974;12462.81305780414;12557;12607.306598137098;12715.809262861065;3965.7025723070883;3982.7411218270718;4036.0717035082093;4037.4953130858644;4155.750654960712;56237;56514.71742641261;56839.71580142073;56914;56979.43020569783;11703.414829258674;12212.511499540096;12220.816687749691;12343.567975121006;12359.876401236052;21838.23566175176;21841.890790546262;21881.234156804436;21949.122035118417;22077.33767986963;8851.734447966572;8860.86708699357;8873.334499912533;8932.598033088527;8961.955190224007;4878.121938051114;5028.874278143076;5059.595232381401;5083.364579427572;5121.9743901281;3597.082743900341;3651.634836516327;3655.908602284911;3663.743537952371;3665.52348194733;629.3769168523221;646.9870602587922;653.411929263657;660.8876490996446;664.0703015777949;686.4851361478891;757.9052618422697;766.6435107674957;769.3076231391792;780.9648565814553;9903.504824758733;9905.306628536078;10108.646197383203;10125.898741012643;10415;718.8634159509677;754.6792613139394;777.3004296133525;796.5618909599697;823.320760372695;4525.256550762193;4649.163150632851;4656.4877863434995;4668.5564871337165;4673;64393.67803160954;64546;65832;65844;65989.67005165039;60763;61538.38461615416;62084.37915620786;62629.68685156636;63510;57733.42266577364;58426.41573584295;59570.70214648899;60238;60710.69644651748;9841.901580984098;10032.448215348226;10187.796244074929;10255.897441025494;10330.276880618285;38162.045948851504;38769;41361.58638413698;41481.58518414777;42922.14155716931;47151;53933.46066539284;54334.641633959465;54598.454015459334;55191.41255818359;13004.8049279259;13057.02072344559;13277.336133193108;13554.186748795104;13601.931990339985;14538.127712337293;14610.926945365205;14666.413343466142;14851.777223341875;14933.701325973638;13505.392257348247;13563.525276615272;13666.248356340497;13880.305984700522;13897.791533126809;13608.93195534016;13747.862521374658;13788;14009.299535023005;14476.059056161315;13199.802002969771;13514.526991555642;13704.52034178799;14003.509877154658;14083.295835208404;11359.659210223706;11768.176227664324;11769.823452648046;11991.460384282555;12117.27296362221;11168.944155279496;11201.551937922392;11455.312681239153;11512.251703639236;11663.125265605284 05:30:20 INFO - PROCESS | 24110 | __end_tp_report 05:30:20 INFO - PROCESS | 24110 | __start_cc_report 05:30:20 INFO - PROCESS | 24110 | _x_x_mozilla_cycle_collect,344 05:30:20 INFO - PROCESS | 24110 | __end_cc_report 05:30:20 INFO - PROCESS | 24110 | __startTimestamp1464784220060__endTimestamp 05:30:20 INFO - PROCESS | 24110 | 05:30:20 INFO - PROCESS | 24110 | ------- Summary: start ------- 05:30:20 INFO - PROCESS | 24110 | Number of tests: 6 05:30:20 INFO - PROCESS | 24110 | 05:30:20 INFO - PROCESS | 24110 | [#0] dojo.html Cycles:165 Average:5428.09 Median:5673.23 stddev:586.78 (10.3%) stddev-sans-first:564.91 05:30:20 INFO - PROCESS | 24110 | Values: 3324.9 3357.9 3360.9 3386.3 3405.2 5346.3 5383.8 5391.9 5396.0 5398.9 5365.1 5377.3 5398.9 5408.4 5445.3 4847.6 4893.9 4962.6 4975.3 5013.7 4900.1 5008.0 5051.7 5052.3 5065.2 4938.1 4987.5 5016.9 5083.4 5084.9 4962.4 4969.0 4973.6 4985.3 5011.1 4896.6 4935.4 4946.7 4963.8 4969.2 5144.8 5288.2 5352.6 5365.3 5369.5 5783.4 5817.2 5832.2 5833.4 5851.0 5741.8 5904.1 5908.2 5911.3 5923.1 5462.5 5475.0 5514.9 5534.3 5534.7 5944.9 5948.3 5959.2 5967.3 5977.2 5723.8 5747.3 5749.6 5749.8 5757.6 5808.7 5839.9 5844.0 5847.8 5851.1 5804.2 5808.0 5813.6 5818.3 5822.5 5694.8 5759.4 5790.0 5811.1 5814.0 4443.7 4449.9 4454.4 4459.1 4481.0 4014.2 4025.5 4033.8 4060.4 4061.6 5538.5 5635.1 5716.3 5725.5 5739.3 5700.5 5727.1 5728.4 5736.7 5770.9 5609.0 5624.9 5628.9 5631.7 5636.8 4967.6 5028.9 5060.9 5076.7 5083.7 6029.7 6038.6 6055.9 6065.8 6068.1 5788.9 5799.9 5803.3 5804.4 5817.4 6053.9 6128.6 6147.5 6161.8 6182.5 5713.5 5718.3 5723.0 5730.9 5745.4 5703.4 5823.1 5827.6 5832.9 5851.7 5689.4 5742.8 5747.5 5774.0 5775.2 5697.1 5717.4 5736.9 5739.9 5741.5 5537.8 5570.2 5640.5 5673.2 5675.4 5656.9 5671.2 5673.6 5679.8 5737.1 5527.4 5558.2 5572.2 5581.6 5609.1 05:30:20 INFO - PROCESS | 24110 | 05:30:20 INFO - PROCESS | 24110 | [#1] ext.html Cycles:180 Average:66801.56 Median:44185.34 stddev:153835.38 (348.2%) stddev-sans-first:154186.67 05:30:20 INFO - PROCESS | 24110 | Values: 619.2 657.2 676.2 679.5 694.0 40587.4 41106.6 41239.6 41318.6 41387.0 44342.6 44677.8 44858.8 45136.5 45165.3 8858.4 8925.0 8986.1 9014.7 9042.5 8981.8 9051.6 9072.0 9215.0 9326.4 9289.8 9324.1 9356.1 9371.1 9392.4 9203.1 9216.1 9339.4 9355.0 9359.9 9171.8 9245.9 9257.0 9315.5 9345.2 43466.1 43589.3 43659.3 43908.6 44028.1 3809.6 4011.3 4027.0 4202.6 4487.9 33817.5 34774.8 34806.5 34996.8 36326.5 4481.1 4576.5 4631.9 4634.3 4664.9 220882.0 222119.0 222377.0 223160.0 223328.0 59778.4 59948.7 60420.1 60442.1 60462.7 71255.0 73243.0 73465.3 73894.3 73911.6 18654.5 18764.2 18850.7 18869.5 18888.2 13992.1 14013.6 14034.8 14046.5 14064.2 20666.3 20684.3 20923.3 21002.3 21635.5 7733.3 7743.7 7779.0 7971.2 7996.8 1170.4 1187.3 1193.7 1241.3 1261.4 34490.0 34525.8 34550.0 34947.0 34969.5 1238.6 1264.9 1290.7 1290.9 1300.3 17740.8 17984.0 17989.0 18034.7 18184.7 494555.0 505331.0 954390.0 963603.0 1074042.0 66341.0 67215.3 67474.3 67475.3 67561.0 1564.3 1577.6 1584.7 1589.2 1670.4 34069.7 35048.0 35173.0 35295.8 35533.0 58586.4 59328.1 59453.0 59930.4 59939.7 466967.0 468799.0 469029.0 469916.0 470044.0 31675.8 31866.8 31929.8 31976.7 32556.0 53898.0 54073.7 54726.7 54891.5 54961.7 44559.6 44626.8 45036.3 45520.0 45644.8 42380.6 44765.3 45433.8 45498.3 46272.5 39554.0 39891.8 39986.4 40317.2 40554.0 34351.3 34611.7 34891.7 34967.8 35105.5 30085.0 30306.8 30345.7 30413.7 30598.2 05:30:20 INFO - PROCESS | 24110 | 05:30:20 INFO - PROCESS | 24110 | [#2] jquery.html Cycles:180 Average:29256.83 Median:12875.26 stddev:83071.67 (645.2%) stddev-sans-first:83276.49 05:30:20 INFO - PROCESS | 24110 | Values: 420.3 423.4 423.6 424.2 434.0 19594.0 20130.6 20493.9 20926.8 21329.8 20428.6 20576.8 21410.0 21437.7 21465.0 5528.9 5750.2 5843.8 5852.5 5860.8 5762.8 5810.5 5828.4 5875.3 5877.6 5685.7 5766.2 5811.6 5845.8 5847.0 5640.9 5670.8 5680.1 5685.3 5721.2 5125.6 5238.2 5248.1 5262.2 5265.6 20870.4 21845.9 21871.1 23290.0 24629.0 2460.5 2461.5 2605.3 2736.4 2970.5 10519.2 10560.0 10719.3 10877.3 13724.0 1912.0 1943.2 2054.8 2088.9 2165.1 62924.4 64414.7 64605.4 81388.6 82382.6 9057.4 10666.3 10841.6 10952.3 11123.6 14974.5 15067.0 15075.5 15109.6 15170.1 8142.3 8365.7 8524.3 8735.3 8755.4 8393.1 8491.1 8514.4 8598.1 8634.0 5019.1 5021.2 5045.5 5080.6 5123.8 2014.8 2074.8 2086.2 2093.4 2130.4 1007.2 1059.3 1092.8 1126.2 1162.8 18998.9 19491.2 19694.9 19900.4 19997.8 1036.5 1059.8 1069.3 1077.8 1141.2 10977.2 11198.9 11216.7 11235.4 11274.9 496603.0 497714.0 498986.0 502317.0 532029.7 62714.0 90243.0 94604.5 96470.0 99004.0 986.5 1031.2 1079.3 1116.5 1148.5 16180.6 17455.3 17650.5 18113.0 18373.7 38989.4 40143.6 40472.8 40683.2 41711.8 56471.0 58417.4 58512.0 59154.7 59275.1 8996.6 9236.6 9238.0 9298.9 9321.3 13437.3 13467.1 13485.5 13725.9 13835.2 11436.3 11542.5 11573.8 11692.5 11880.8 11619.5 11639.4 11674.0 12109.4 12379.1 12068.6 12114.1 12125.8 12249.8 12581.8 8788.5 8855.0 8919.9 8967.1 9036.2 9174.3 12140.9 12164.4 12223.9 12453.0 05:30:20 INFO - PROCESS | 24110 | 05:30:20 INFO - PROCESS | 24110 | [#3] mootools.html Cycles:180 Average:5430.29 Median:5177.95 stddev:2890.91 (55.8%) stddev-sans-first:2884.51 05:30:20 INFO - PROCESS | 24110 | Values: 1577.3 1593.3 1830.4 1924.0 1932.0 7370.2 7921.9 8036.8 8188.7 8292.9 8035.3 8083.7 8094.1 8103.5 8133.2 2357.9 2361.7 2375.9 2378.3 2379.0 2275.9 2303.6 2394.3 2394.7 2395.8 2376.4 2378.8 2384.9 2450.2 2454.0 2424.2 2432.1 2432.8 2437.4 2468.5 2419.3 2434.7 2439.6 2442.7 2445.4 8330.5 8368.6 8372.2 8378.4 8388.1 5155.9 5203.2 5207.6 5252.9 5255.0 3368.2 3390.9 3419.8 3420.1 3437.2 1132.9 1138.2 1145.7 1147.7 1168.3 11283.6 11369.9 11382.4 11391.6 11400.8 4492.9 4550.1 4600.4 4616.7 4651.7 9599.5 9659.2 9666.0 9669.4 9685.9 5199.9 5225.2 5240.5 5251.0 5257.4 4243.4 4652.9 4709.9 4754.9 4801.1 3956.7 3983.6 4021.7 4025.2 4072.8 1284.2 1287.9 1320.4 1321.6 1339.9 1038.7 1041.0 1060.4 1067.4 1071.8 5834.9 5845.2 5938.5 6063.6 6146.8 442.1 444.0 444.4 448.7 1042.7 4038.0 4101.1 4102.3 4104.9 4112.7 9521.5 9761.9 9922.3 9932.2 9946.6 9642.9 9681.6 9782.9 9788.1 9830.8 7163.7 7208.7 7325.7 7503.8 7532.7 5407.6 5430.6 5507.6 5516.1 5547.2 8341.2 8348.7 8422.9 8540.3 8547.4 8550.8 8606.4 8655.5 8691.2 8714.7 6729.1 7040.5 7187.2 7355.0 7445.8 7718.5 7744.6 7766.2 7793.6 7808.3 6741.8 6950.8 6983.2 6997.0 7061.2 6967.4 6975.1 6975.8 7026.6 7079.8 6754.2 6787.2 6830.2 6879.1 6886.7 4790.0 4794.8 4871.6 4883.5 4960.7 4961.2 4992.0 5004.6 5060.0 5078.5 05:30:20 INFO - PROCESS | 24110 | 05:30:20 INFO - PROCESS | 24110 | [#4] prototype.html Cycles:180 Average:5827.23 Median:6719.25 stddev:1834.65 (27.3%) stddev-sans-first:1792.76 05:30:20 INFO - PROCESS | 24110 | Values: 327.6 331.0 339.3 339.6 340.9 6380.9 6570.3 6601.7 6669.0 6672.0 6617.0 6626.8 6654.2 6655.2 6659.9 4908.8 4917.6 4920.0 4923.0 4929.1 4930.4 4932.4 4942.1 4942.6 4945.3 4869.0 4875.6 4876.1 4882.0 4887.7 4666.4 4841.3 4884.5 4886.9 4895.2 4183.6 4192.2 4197.0 4200.0 4202.0 6281.4 6300.9 6303.5 6305.7 6316.0 5657.0 5709.3 5709.9 5711.0 5716.8 6936.3 6964.8 6979.0 6979.8 7031.0 4510.2 4656.4 4692.0 4693.7 4698.4 7245.1 7250.6 7274.2 7312.9 7327.9 4716.0 4759.5 4763.2 4771.1 4772.7 4833.8 4841.7 4844.4 4847.7 4853.2 5675.0 5691.0 5692.2 5694.3 5705.4 6845.0 6996.1 7020.3 7028.8 7062.3 1666.3 1677.3 1685.9 1691.0 1692.4 1027.1 1045.4 1060.8 1073.7 1074.1 6660.5 6868.5 6909.7 6910.4 6944.8 7277.0 7281.7 7283.0 7303.6 7311.5 6876.1 6884.8 6896.6 6903.3 6907.1 3871.8 3875.9 3917.5 3939.1 3946.3 7673.3 7675.7 7680.8 7688.8 7690.4 7422.0 7431.1 7465.1 7473.4 7474.5 7604.8 7667.2 7678.5 7686.2 7687.5 7058.2 7262.1 7269.7 7279.5 7281.1 7153.7 7171.7 7178.6 7187.0 7191.2 7664.6 7679.7 7680.4 7683.2 7689.1 4643.8 4648.9 4680.4 4681.4 4698.1 7064.6 7201.6 7234.7 7249.5 7257.3 6984.3 6998.2 6999.5 7005.9 7032.5 6988.4 6991.5 6992.3 7014.1 7019.9 6857.7 6890.6 6902.8 6912.8 6917.0 6799.8 7009.9 7073.4 7075.9 7093.9 6766.5 6924.5 6925.0 6938.9 6939.5 05:30:20 INFO - PROCESS | 24110 | 05:30:20 INFO - PROCESS | 24110 | [#5] yui.html Cycles:180 Average:16317.66 Median:23538.95 stddev:19020.20 (80.8%) stddev-sans-first:19037.93 05:30:20 INFO - PROCESS | 24110 | Values: 816.4 861.3 913.5 918.3 924.2 13807.8 13887.0 14160.4 14409.7 14589.8 13416.2 13453.3 13459.0 13460.3 13488.5 757.6 904.0 917.1 923.5 925.0 914.6 916.2 918.1 919.7 920.4 970.4 972.1 973.7 974.9 976.9 961.1 962.3 964.0 967.7 970.5 716.4 717.1 717.5 719.1 719.3 13985.0 13994.6 14022.1 14034.5 14047.8 15434.9 15455.9 15562.0 15692.2 15731.0 12398.8 12462.8 12557.0 12607.3 12715.8 3965.7 3982.7 4036.1 4037.5 4155.8 56237.0 56514.7 56839.7 56914.0 56979.4 11703.4 12212.5 12220.8 12343.6 12359.9 21838.2 21841.9 21881.2 21949.1 22077.3 8851.7 8860.9 8873.3 8932.6 8962.0 4878.1 5028.9 5059.6 5083.4 5122.0 3597.1 3651.6 3655.9 3663.7 3665.5 629.4 647.0 653.4 660.9 664.1 686.5 757.9 766.6 769.3 781.0 9903.5 9905.3 10108.6 10125.9 10415.0 718.9 754.7 777.3 796.6 823.3 4525.3 4649.2 4656.5 4668.6 4673.0 64393.7 64546.0 65832.0 65844.0 65989.7 60763.0 61538.4 62084.4 62629.7 63510.0 57733.4 58426.4 59570.7 60238.0 60710.7 9841.9 10032.4 10187.8 10255.9 10330.3 38162.0 38769.0 41361.6 41481.6 42922.1 47151.0 53933.5 54334.6 54598.5 55191.4 13004.8 13057.0 13277.3 13554.2 13601.9 14538.1 14610.9 14666.4 14851.8 14933.7 13505.4 13563.5 13666.2 13880.3 13897.8 13608.9 13747.9 13788.0 14009.3 14476.1 13199.8 13514.5 13704.5 14003.5 14083.3 11359.7 11768.2 11769.8 11991.5 12117.3 11168.9 11201.6 11455.3 11512.3 11663.1 05:30:20 INFO - PROCESS | 24110 | -------- Summary: end -------- 05:30:20 INFO - PROCESS | 24110 | 05:30:20 INFO - TEST-INFO | 24110: exit 0 05:30:20 INFO - TEST-OK | dromaeo_css | took 1109518ms 05:30:20 INFO - TEST-START | kraken 05:30:20 INFO - operating with platform_type : linux_ 05:30:20 INFO - Initialising browser for kraken test... 05:30:20 INFO - TEST-INFO | started process 24354 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQTItZS/profile http://localhost:41585/getInfo.html) 05:30:24 INFO - PROCESS | 24354 | 05:30:24 INFO - PROCESS | 24354 | (process:24431): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:30:25 INFO - PROCESS | 24354 | __metrics Screen width/height:1600/1200 05:30:25 INFO - PROCESS | 24354 | colorDepth:24 05:30:25 INFO - PROCESS | 24354 | Browser inner width/height: 1024/697 05:30:25 INFO - PROCESS | 24354 | __metrics 05:30:26 ERROR - PROCESS | 24354 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 05:30:27 INFO - TEST-INFO | 24354: exit 0 05:30:27 INFO - Browser initialized. 05:30:27 INFO - Running cycle 1/1 for kraken test... 05:30:27 INFO - TEST-INFO | started process 24482 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQTItZS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:30:29 INFO - PROCESS | 24482 | 05:30:29 INFO - PROCESS | 24482 | (process:24550): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:30:39 INFO - PROCESS | 24482 | RSS: Main: 152424448 05:30:39 INFO - PROCESS | 24482 | 05:30:41 INFO - PROCESS | 24482 | Cycle 1(1): loaded http://localhost:41585/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41585/tests/kraken/driver.html?testName=audio-beat-detection) 05:30:42 INFO - PROCESS | 24482 | RSS: Main: 157405184 05:30:42 INFO - PROCESS | 24482 | 05:30:45 INFO - PROCESS | 24482 | Cycle 1(1): loaded http://localhost:41585/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41585/tests/kraken/driver.html?testName=audio-dft) 05:30:46 INFO - PROCESS | 24482 | RSS: Main: 157265920 05:30:46 INFO - PROCESS | 24482 | 05:30:48 INFO - PROCESS | 24482 | Cycle 1(1): loaded http://localhost:41585/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41585/tests/kraken/driver.html?testName=audio-fft) 05:30:49 INFO - PROCESS | 24482 | RSS: Main: 157630464 05:30:49 INFO - PROCESS | 24482 | 05:30:51 INFO - PROCESS | 24482 | Cycle 1(1): loaded http://localhost:41585/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41585/tests/kraken/driver.html?testName=audio-oscillator) 05:30:52 INFO - PROCESS | 24482 | RSS: Main: 157057024 05:30:52 INFO - PROCESS | 24482 | 05:30:54 INFO - PROCESS | 24482 | Cycle 1(1): loaded http://localhost:41585/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41585/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:30:55 INFO - PROCESS | 24482 | RSS: Main: 156958720 05:30:55 INFO - PROCESS | 24482 | 05:30:58 INFO - PROCESS | 24482 | Cycle 1(1): loaded http://localhost:41585/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41585/tests/kraken/driver.html?testName=imaging-darkroom) 05:30:58 INFO - PROCESS | 24482 | RSS: Main: 157478912 05:30:58 INFO - PROCESS | 24482 | 05:31:02 INFO - PROCESS | 24482 | Cycle 1(1): loaded http://localhost:41585/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41585/tests/kraken/driver.html?testName=imaging-desaturate) 05:31:02 INFO - PROCESS | 24482 | RSS: Main: 157376512 05:31:02 INFO - PROCESS | 24482 | 05:31:05 INFO - PROCESS | 24482 | Cycle 1(1): loaded http://localhost:41585/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41585/tests/kraken/driver.html?testName=json-parse-financial) 05:31:06 INFO - PROCESS | 24482 | RSS: Main: 157634560 05:31:06 INFO - PROCESS | 24482 | 05:31:07 INFO - PROCESS | 24482 | Cycle 1(1): loaded http://localhost:41585/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41585/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:31:08 INFO - PROCESS | 24482 | RSS: Main: 157724672 05:31:08 INFO - PROCESS | 24482 | 05:31:10 INFO - PROCESS | 24482 | Cycle 1(1): loaded http://localhost:41585/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41585/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:31:10 INFO - PROCESS | 24482 | RSS: Main: 157798400 05:31:10 INFO - PROCESS | 24482 | 05:31:12 INFO - PROCESS | 24482 | Cycle 1(1): loaded http://localhost:41585/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41585/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:31:13 INFO - PROCESS | 24482 | RSS: Main: 157949952 05:31:13 INFO - PROCESS | 24482 | 05:31:15 INFO - PROCESS | 24482 | Cycle 1(1): loaded http://localhost:41585/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41585/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:31:16 INFO - PROCESS | 24482 | RSS: Main: 157937664 05:31:16 INFO - PROCESS | 24482 | 05:31:19 INFO - PROCESS | 24482 | Cycle 1(1): loaded http://localhost:41585/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41585/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:31:19 INFO - PROCESS | 24482 | RSS: Main: 157949952 05:31:19 INFO - PROCESS | 24482 | 05:31:21 INFO - PROCESS | 24482 | Cycle 1(1): loaded http://localhost:41585/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41585/tests/kraken/driver.html?testName=ai-astar) 05:31:21 INFO - PROCESS | 24482 | RSS: Main: 159522816 05:31:21 INFO - PROCESS | 24482 | 05:31:21 INFO - PROCESS | 24482 | __start_tp_report 05:31:21 INFO - PROCESS | 24482 | _x_x_mozilla_page_load 05:31:21 INFO - PROCESS | 24482 | _x_x_mozilla_page_load_details 05:31:21 INFO - PROCESS | 24482 | |i|pagename|runs| 05:31:21 INFO - PROCESS | 24482 | |0;ai-astar;107;111;104;113;111;115;101;109;110;110 05:31:21 INFO - PROCESS | 24482 | |1;audio-beat-detection;164;130;162;183;129;161;155;129;182;129 05:31:21 INFO - PROCESS | 24482 | |2;audio-dft;163;165;165;164;163;163;163;163;164;164 05:31:21 INFO - PROCESS | 24482 | |3;audio-fft;77;74;77;169;77;76;76;76;156;77 05:31:21 INFO - PROCESS | 24482 | |4;audio-oscillator;92;94;149;92;93;92;159;93;93;159 05:31:21 INFO - PROCESS | 24482 | |5;imaging-gaussian-blur;117;118;117;118;118;118;117;117;117;117 05:31:21 INFO - PROCESS | 24482 | |6;imaging-darkroom;148;147;147;146;147;154;147;146;147;146 05:31:21 INFO - PROCESS | 24482 | |7;imaging-desaturate;96;95;97;95;95;95;95;100;95;95 05:31:21 INFO - PROCESS | 24482 | |8;json-parse-financial;54;56;54;55;57;60;55;77;54;56 05:31:21 INFO - PROCESS | 24482 | |9;json-stringify-tinderbox;60;59;59;59;60;58;58;59;60;60 05:31:21 INFO - PROCESS | 24482 | |10;stanford-crypto-aes;73;72;75;72;72;80;74;74;76;75 05:31:21 INFO - PROCESS | 24482 | |11;stanford-crypto-ccm;115;115;117;121;117;118;114;116;131;135 05:31:21 INFO - PROCESS | 24482 | |12;stanford-crypto-pbkdf2;168;157;158;167;160;166;157;160;164;162 05:31:21 INFO - PROCESS | 24482 | |13;stanford-crypto-sha256-iterative;66;68;68;66;66;64;65;66;64;65 05:31:21 INFO - PROCESS | 24482 | __end_tp_report 05:31:21 INFO - PROCESS | 24482 | __start_cc_report 05:31:21 INFO - PROCESS | 24482 | _x_x_mozilla_cycle_collect,868 05:31:21 INFO - PROCESS | 24482 | __end_cc_report 05:31:21 INFO - PROCESS | 24482 | __startTimestamp1464784281692__endTimestamp 05:31:21 INFO - PROCESS | 24482 | 05:31:21 INFO - PROCESS | 24482 | ------- Summary: start ------- 05:31:21 INFO - PROCESS | 24482 | Number of tests: 14 05:31:21 INFO - PROCESS | 24482 | 05:31:21 INFO - PROCESS | 24482 | [#0] ai-astar Cycles:10 Average:109.10 Median:110.50 stddev:4.15 (3.8%) stddev-sans-first:4.33 05:31:21 INFO - PROCESS | 24482 | Values: 107.0 111.0 104.0 113.0 111.0 115.0 101.0 109.0 110.0 110.0 05:31:21 INFO - PROCESS | 24482 | 05:31:21 INFO - PROCESS | 24482 | [#1] audio-beat-detection Cycles:10 Average:152.40 Median:161.50 stddev:21.77 (13.5%) stddev-sans-first:22.68 05:31:21 INFO - PROCESS | 24482 | Values: 164.0 130.0 162.0 183.0 129.0 161.0 155.0 129.0 182.0 129.0 05:31:21 INFO - PROCESS | 24482 | 05:31:21 INFO - PROCESS | 24482 | [#2] audio-dft Cycles:10 Average:163.70 Median:164.00 stddev:0.82 (0.5%) stddev-sans-first:0.83 05:31:21 INFO - PROCESS | 24482 | Values: 163.0 165.0 165.0 164.0 163.0 163.0 163.0 163.0 164.0 164.0 05:31:21 INFO - PROCESS | 24482 | 05:31:21 INFO - PROCESS | 24482 | [#3] audio-fft Cycles:10 Average:93.50 Median:76.50 stddev:36.51 (47.7%) stddev-sans-first:38.23 05:31:21 INFO - PROCESS | 24482 | Values: 77.0 74.0 77.0 169.0 77.0 76.0 76.0 76.0 156.0 77.0 05:31:21 INFO - PROCESS | 24482 | 05:31:21 INFO - PROCESS | 24482 | [#4] audio-oscillator Cycles:10 Average:111.60 Median:92.50 stddev:30.54 (33.0%) stddev-sans-first:31.55 05:31:21 INFO - PROCESS | 24482 | Values: 92.0 94.0 149.0 92.0 93.0 92.0 159.0 93.0 93.0 159.0 05:31:21 INFO - PROCESS | 24482 | 05:31:21 INFO - PROCESS | 24482 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 05:31:21 INFO - PROCESS | 24482 | Values: 117.0 118.0 117.0 118.0 118.0 118.0 117.0 117.0 117.0 117.0 05:31:21 INFO - PROCESS | 24482 | 05:31:21 INFO - PROCESS | 24482 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.00 stddev:2.37 (1.6%) stddev-sans-first:2.51 05:31:21 INFO - PROCESS | 24482 | Values: 148.0 147.0 147.0 146.0 147.0 154.0 147.0 146.0 147.0 146.0 05:31:21 INFO - PROCESS | 24482 | 05:31:21 INFO - PROCESS | 24482 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:95.00 stddev:1.62 (1.7%) stddev-sans-first:1.72 05:31:21 INFO - PROCESS | 24482 | Values: 96.0 95.0 97.0 95.0 95.0 95.0 95.0 100.0 95.0 95.0 05:31:21 INFO - PROCESS | 24482 | 05:31:21 INFO - PROCESS | 24482 | [#8] json-parse-financial Cycles:10 Average:57.80 Median:56.00 stddev:6.99 (12.5%) stddev-sans-first:7.28 05:31:21 INFO - PROCESS | 24482 | Values: 54.0 56.0 54.0 55.0 57.0 60.0 55.0 77.0 54.0 56.0 05:31:21 INFO - PROCESS | 24482 | 05:31:21 INFO - PROCESS | 24482 | [#9] json-stringify-tinderbox Cycles:10 Average:59.20 Median:59.50 stddev:0.79 (1.3%) stddev-sans-first:0.78 05:31:21 INFO - PROCESS | 24482 | Values: 60.0 59.0 59.0 59.0 60.0 58.0 58.0 59.0 60.0 60.0 05:31:21 INFO - PROCESS | 24482 | 05:31:21 INFO - PROCESS | 24482 | [#10] stanford-crypto-aes Cycles:10 Average:74.30 Median:74.50 stddev:2.45 (3.3%) stddev-sans-first:2.55 05:31:21 INFO - PROCESS | 24482 | Values: 73.0 72.0 75.0 72.0 72.0 80.0 74.0 74.0 76.0 75.0 05:31:21 INFO - PROCESS | 24482 | 05:31:21 INFO - PROCESS | 24482 | [#11] stanford-crypto-ccm Cycles:10 Average:119.90 Median:117.50 stddev:7.23 (6.2%) stddev-sans-first:7.45 05:31:21 INFO - PROCESS | 24482 | Values: 115.0 115.0 117.0 121.0 117.0 118.0 114.0 116.0 131.0 135.0 05:31:21 INFO - PROCESS | 24482 | 05:31:21 INFO - PROCESS | 24482 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.90 Median:163.00 stddev:4.15 (2.5%) stddev-sans-first:3.77 05:31:21 INFO - PROCESS | 24482 | Values: 168.0 157.0 158.0 167.0 160.0 166.0 157.0 160.0 164.0 162.0 05:31:21 INFO - PROCESS | 24482 | 05:31:21 INFO - PROCESS | 24482 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:66.00 stddev:1.40 (2.1%) stddev-sans-first:1.48 05:31:21 INFO - PROCESS | 24482 | Values: 66.0 68.0 68.0 66.0 66.0 64.0 65.0 66.0 64.0 65.0 05:31:21 INFO - PROCESS | 24482 | -------- Summary: end -------- 05:31:21 INFO - PROCESS | 24482 | 05:31:22 INFO - TEST-INFO | 24482: exit 0 05:31:22 INFO - TEST-OK | kraken | took 61883ms 05:31:22 INFO - SUITE-END | took 1171s 05:31:22 INFO - Completed test suite (00:19:31) 05:31:22 INFO - javascript benchmark 05:31:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3324.8670053197875, 3357.949630755538, 3360.8655653773844, 3386.2888793353395, 3405.1997780521574, 5346.27825243592, 5383.784648614051, 5391.946080539194, 5396.028714831334, 5398.946010539898, 5365.087935051041, 5377.327834020747, 5398.865028374283, 5408.4050754416985, 5445.319335083114, 4847.563719265274, 4893.8776530586665, 4962.60299176065, 4975.253711943201, 5013.699178049311, 4900.117978763821, 5008.023435430093, 5051.722155281458, 5052.26742122392, 5065.214891691794, 4938.135826230413, 4987.451380348159, 5016.8996620067755, 5083.440821509631, 5084.9321642455125, 4962.3548938638105, 4968.975155124237, 4973.602111831045, 4985.277134815449, 5011.123053465665, 4896.60827133832, 4935.383077115361, 4946.653734238605, 4963.826266080706, 4969.204927211629, 5144.768485418165, 5288.153895376721, 5352.571794256489, 5365.302510673627, 5369.5167434931045, 5783.363829978741, 5817.214676018725, 5832.212651292064, 5833.358330583633, 5850.970745146247, 5741.827745167651, 5904.143899134644, 5908.231929849135, 5911.290645122613, 5923.111533270001, 5462.535684466825, 5474.972625136888, 5514.944850551483, 5534.308211473566, 5534.723263836792, 5944.910826337608, 5948.286205655262, 5959.165716799652, 5967.343592204854, 5977.222961015127, 5723.828285151452, 5747.339056008529, 5749.568782341257, 5749.8275051748515, 5757.568182386338, 5808.651480911159, 5839.854003649943, 5844.0, 5847.8245652630485, 5851.063829787214, 5804.187413762077, 5808.0, 5813.6221145625395, 5818.272715910512, 5822.534197264209, 5694.829155125353, 5759.395263497357, 5789.971050144806, 5811.070228763378, 5814.040683287295, 4443.711158774734, 4449.866504004885, 4454.354118652777, 4459.063596644741, 4481.014176881081, 4014.197160567898, 4025.496812898388, 4033.778142202207, 4060.4315395844606, 4061.634452899253, 5538.529225015919, 5635.0702134147405, 5716.256886604715, 5725.541956643458, 5739.339975902742, 5700.543956483471, 5727.140928860705, 5728.369879313273, 5736.741846616912, 5770.855728606734, 5609.046462101453, 5624.943750562442, 5628.887422251614, 5631.662100273915, 5636.830895073154, 4967.627427942919, 5028.949710502849, 5060.924086138711, 5076.720780357042, 5083.669561478492, 6029.6683682397015, 6038.607490513103, 6055.878882422327, 6065.75736970525, 6068.059450785136, 5788.913166302593, 5799.884002320015, 5803.332616749128, 5804.419558044162, 5817.389174136655, 6053.939460605337, 6128.564234752123, 6147.538934579835, 6161.815145545641, 6182.536309776875, 5713.542916566582, 5718.25662663851, 5722.971385143048, 5730.942690573041, 5745.368009519033, 5703.401142880104, 5823.068309070529, 5827.621204621686, 5832.854178645568, 5851.678157701367, 5689.402612725769, 5742.7702891883855, 5747.453991870766, 5774.0, 5775.249217601685, 5697.088465845445, 5717.42825717425, 5736.856578585569, 5739.942600573941, 5741.45456181662, 5537.833864983896, 5570.220169176399, 5640.492355688008, 5673.234113394639, 5675.375708671961, 5656.85857853557, 5671.234383358194, 5673.574481913791, 5679.801206957736, 5737.139429085503, 5527.39198688152, 5558.249636299048, 5572.192032155396, 5581.553475722014, 5609.102543593169], "value": 5391.339948796444, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [619.1950464396286, 657.2441692054138, 676.1818199978027, 679.5481005131585, 694.0491526608547, 40587.39118913215, 41106.58893411065, 41239.587604123946, 41318.58681413185, 41387.0, 44342.556574434246, 44677.77661111698, 44858.77570612151, 45136.548634513645, 45165.322520162226, 8858.379913406048, 8925.0, 8986.101389860994, 9014.729558113235, 9042.457452552835, 8981.820363592724, 9051.637934482613, 9072.0, 9215.0, 9326.393784404027, 9289.767755806126, 9324.11420915012, 9356.111169438893, 9371.109744574254, 9392.436453812794, 9203.079692030777, 9216.124468175512, 9339.392939458914, 9354.95322523383, 9359.906400936039, 9171.816563668755, 9245.907540924572, 9257.028012058772, 9315.534223288876, 9345.20565751905, 43466.130677386274, 43589.346159807625, 43659.34510982338, 43908.560914390764, 44028.119437611065, 3809.6190380961684, 4011.3180759270704, 4027.0335119571387, 4202.621764041251, 4487.887802804923, 33817.492737608954, 34774.82612586946, 34806.47790283148, 34996.825015874754, 36326.45510317347, 4481.148581769454, 4576.54234576543, 4631.861044168681, 4634.304854271886, 4664.86005419838, 220882.0, 222119.0, 222377.0, 223160.0, 223328.0, 59778.40221597815, 59948.700256498436, 60420.09369859456, 60442.093368598624, 60462.69768651129, 71255.0, 73243.0, 73465.26534734585, 73894.26105738981, 73911.63044184745, 18654.53363665892, 18764.24943002292, 18850.71723924142, 18869.52826179329, 18888.244470221038, 13992.09051411655, 14013.649658758613, 14034.789478157836, 14046.508372206923, 14064.226467544384, 20666.276680316118, 20684.276050338165, 20923.26768563093, 21002.264920727703, 21635.459113521974, 7733.342665873463, 7743.7476259970945, 7779.0, 7971.242731940456, 7996.760097197093, 1170.4440390814295, 1187.2994932989577, 1193.671740271415, 1241.2614494375832, 1261.369315342329, 34490.0, 34525.82737086349, 34550.0, 34947.0, 34969.47545786815, 1238.646985609097, 1264.8988080953502, 1290.677330667333, 1290.8580056193812, 1300.2718477652545, 17740.822591774177, 17984.0, 17989.0, 18034.729479057823, 18184.727229091575, 494555.0, 505331.0, 954390.0, 963603.0, 1074042.0, 66341.0, 67215.32784672189, 67474.32525674779, 67475.32524674789, 67561.0, 1564.327339244136, 1577.6213708710056, 1584.67514159597, 1589.2212815720213, 1670.448751911866, 34069.659303406646, 35048.0, 35173.0, 35295.82352088223, 35533.0, 58586.4141358581, 59328.11007834799, 59453.0, 59930.40069599248, 59939.70030149821, 466967.0, 468799.0, 469029.0, 469916.0, 470044.0, 31675.841620791747, 31866.840665796524, 31929.8403507981, 31976.6802331983, 32556.0, 53898.0, 54073.72963135159, 54726.726366369505, 54891.45108548863, 54961.725191373785, 44559.55440445684, 44626.77686611546, 45036.32445513254, 45520.0, 45644.77177614091, 42380.57619423766, 44765.32852007288, 45433.77283113563, 45498.31752523649, 46272.537274626826, 39554.0, 39891.80054099711, 39986.400203997546, 40317.1936561273, 40554.0, 34351.31297374088, 34611.65388346185, 34891.65108348986, 34967.82516087403, 35105.473417899266, 30085.0, 30306.787728491494, 30345.696543034286, 30413.695863041085, 30598.235044124074], "value": 21653.99133380883, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [420.26873240561423, 423.38186248077807, 423.6187431311821, 424.20461634435435, 433.9587739164778, 19594.0, 20130.643972921796, 20493.897530512364, 20926.790732092675, 21329.786702132973, 20428.591428171465, 20576.794232057677, 21410.0, 21437.67843482349, 21465.0, 5528.9494995950745, 5750.166225897243, 5843.79546715865, 5852.531797456215, 5860.765569377219, 5762.798302059428, 5810.477057064863, 5828.388019257981, 5875.324337701155, 5877.617954832944, 5685.744141513642, 5766.1639062335935, 5811.593188476808, 5845.766169353242, 5847.0352391855295, 5640.915386269209, 5670.809130082687, 5680.147977803321, 5685.346185188715, 5721.199032135504, 5125.641205115643, 5238.1618940969265, 5248.0553500369915, 5262.158054711228, 5265.605079619006, 20870.37388878336, 21845.890770546204, 21871.12515499378, 23290.0, 24629.0, 2460.5201985612634, 2461.507698460297, 2605.3226161198036, 2736.411671490619, 2970.4504666636526, 10519.211059170593, 10560.049595536362, 10719.303245289031, 10877.347359158475, 13724.039317247796, 1911.9617607647908, 1943.2129987355145, 2054.7739748627637, 2088.853780235384, 2165.058199683143, 62924.37075629277, 64414.67792661054, 64605.353946460404, 81388.59305703433, 82382.58808705978, 9057.411268267673, 10666.253362264568, 10841.566337346576, 10952.288101273392, 11123.55393798801, 14974.475893343899, 15067.0, 15075.54773356801, 15109.622259443602, 15170.089794612139, 8142.307903828241, 8365.749027529062, 8524.27543658796, 8735.25750311218, 8755.387122901337, 8393.118722534167, 8491.108433614505, 8514.403991720521, 8598.140185981352, 8633.95683021581, 5019.121653710659, 5021.246812978009, 5045.520675535891, 5080.59355251579, 5123.846284611468, 2014.8441167950446, 2074.792520747913, 2086.196814226503, 2093.4347726113865, 2130.403487023636, 1007.2345017786535, 1059.3061544688242, 1092.7541303206715, 1126.2397881430002, 1162.7558212775411, 18998.905005474884, 19491.22035118608, 19694.90152549257, 19900.402987910387, 19997.800021999883, 1036.4713995862164, 1059.7774467361787, 1069.3316677076828, 1077.8006068877282, 1141.2353723005606, 10977.231593788358, 11198.944005280084, 11216.66350009501, 11235.438228088562, 11274.887251127384, 496603.0, 497714.0, 498986.0, 502317.0, 532029.7383643859, 62714.0, 90243.0, 94604.52697736467, 96470.0, 99004.0, 986.4771671014374, 1031.2471895516314, 1079.32002838213, 1116.4864162485185, 1148.4717030166216, 16180.595485112966, 17455.30178792834, 17650.470485885446, 18113.0, 18373.72439413383, 38989.41515877208, 40143.598564015156, 40472.79763601281, 40683.1863362737, 41711.7914410426, 56471.0, 58417.415825842894, 58512.0, 59154.70422647859, 59275.110873336074, 8996.595153218252, 9236.630534778533, 9238.0, 9298.907010929805, 9321.347505674537, 13437.328133593086, 13467.12463689857, 13485.528006519724, 13725.931370343083, 13835.239061851695, 11436.313821170756, 11542.538298468304, 11573.768524629291, 11692.47383867745, 11880.821787673365, 11619.535218591162, 11639.359835209145, 11674.0, 12109.394530273627, 12379.133460657667, 12068.577599783965, 12114.091443141624, 12125.75748485043, 12249.816252756038, 12581.811272831097, 8788.472691638523, 8854.955725221333, 8919.910800891908, 8967.058458861986, 9036.23192028685, 9174.311926605398, 12140.939295303468, 12164.39178041112, 12223.93888030554, 12453.0], "value": 9470.289004127242, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1577.3217516467919, 1593.2909855114476, 1830.4417152768408, 1923.9807601923976, 1932.0339830084965, 7370.152432470268, 7921.881171782428, 8036.799080023003, 8188.672453101876, 8292.917070829297, 8035.3169980551575, 8083.676652933876, 8094.109647938722, 8103.473274237185, 8133.186681331864, 2357.893894774735, 2361.740208577055, 2375.8574485530835, 2378.3102900158933, 2379.048380647746, 2275.8862056897174, 2303.6199027160496, 2394.2817154853474, 2394.7485514021037, 2395.8499920038394, 2376.429656882353, 2378.8453750506246, 2384.880755962195, 2450.191436825843, 2453.9754602454013, 2424.200013995395, 2432.136591510015, 2432.8418652787514, 2437.390652336916, 2468.5062987402594, 2419.334682962182, 2434.732179460258, 2439.597466418039, 2442.7312995570474, 2445.376429010591, 8330.541820199887, 8368.623411946417, 8372.204640559137, 8378.413511054228, 8388.119247478988, 5155.9484405155845, 5203.16749320107, 5207.557357624606, 5252.947470525284, 5255.02781985334, 3368.2253081791323, 3390.9491357629654, 3419.829008549563, 3420.0765793235687, 3437.1750779812664, 1132.909367250618, 1138.248755821154, 1145.6906635208447, 1147.7015975846257, 1168.263993683982, 11283.605073822459, 11369.943150284278, 11382.430878456044, 11391.601293954755, 11400.828987565194, 4492.887677808081, 4550.067236216634, 4600.378948841931, 4616.676832621684, 4651.651126165551, 9599.520023998772, 9659.227261819038, 9666.0, 9669.371490853073, 9685.854712179324, 5199.948000520022, 5225.242339860775, 5240.528352448298, 5251.0, 5257.395399529027, 4243.427137336482, 4652.906941861143, 4709.858704238878, 4754.904901901942, 4801.135795556764, 3956.742811717229, 3983.5618082010956, 4021.678265738734, 4025.1748391579654, 4072.775997320176, 1284.2487145020268, 1287.9484820607258, 1320.3662242123835, 1321.5572783117764, 1339.9263040532865, 1038.6624347087077, 1041.0474415909357, 1060.3849767135043, 1067.3595842494597, 1071.8124328242527, 5834.854128646818, 5845.181674565564, 5938.495227905676, 6063.636181829104, 6146.78486252979, 442.0584155748236, 444.02314907203635, 444.3978409255477, 448.74645825108706, 1042.6663467690266, 4037.9798101009305, 4101.118259574206, 4102.343625020042, 4104.91790164195, 4112.712110152321, 9521.523923803783, 9761.9023809761, 9922.255830812574, 9932.205423566098, 9946.602135914627, 9642.855357169648, 9681.564329605184, 9782.853257201148, 9788.119069283655, 9830.754231144136, 7163.7134514619875, 7208.747693830691, 7325.670344834495, 7503.7748867534065, 7532.698692052257, 5407.567394608343, 5430.567877114507, 5507.5593952484505, 5516.14499752539, 5547.1679248113105, 8341.16588341161, 8348.707795227137, 8422.91577084246, 8540.27407670355, 8547.40168188221, 8550.78623034429, 8606.354523410644, 8655.48067115975, 8691.217790398894, 8714.69498567547, 6729.1252137221845, 7040.5071644984355, 7187.2453392393045, 7354.96322518384, 7445.813854653677, 7718.459707820399, 7744.612769361397, 7766.223377662414, 7793.571353575608, 7808.258215469521, 6741.764038258638, 6950.756723514653, 6983.1620205575655, 6996.965015174892, 7061.152661680631, 6967.407770339375, 6975.093237879043, 6975.755848545276, 7026.578405295699, 7079.82300442493, 6754.18949726036, 6787.21946976104, 6830.21452532965, 6879.140107486564, 6886.655667216519, 4789.976050119727, 4794.760261986957, 4871.561559459666, 4883.462819089827, 4960.677555958851, 4961.156603377507, 4991.9500804991485, 5004.649674522894, 5059.974700126476, 5078.5175408336145], "value": 4428.297103249578, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.552890304734, 330.9768316217866, 339.3230505142242, 339.623018449521, 340.87728417769586, 6380.872382552347, 6570.277269500357, 6601.66991650418, 6668.966655166723, 6671.999999999994, 6616.966915165417, 6626.768063117792, 6654.234763002256, 6655.168103987002, 6659.933400665992, 4908.803647854082, 4917.582005529534, 4919.950800491985, 4922.950770492303, 4929.137400954836, 4930.433000204968, 4932.383452068491, 4942.061008408391, 4942.604591632661, 4945.258211268302, 4868.951310486903, 4875.561199492045, 4876.122297986361, 4882.048000639877, 4887.7311747853855, 4666.416697912761, 4841.346418233564, 4884.51154884514, 4886.926696099544, 4895.241237608158, 4183.602557757039, 4192.224438478891, 4197.034682023122, 4199.97900010498, 4201.957980420218, 6281.434670879597, 6300.936990630126, 6303.527235457359, 6305.716242769041, 6315.96842015787, 5657.0, 5709.314882214119, 5709.914351284734, 5711.029125048752, 5716.771329146829, 6936.271691472373, 6964.825879353057, 6979.0, 6979.755708550177, 7031.0, 4510.21071312519, 4656.3946686930485, 4692.0381321828945, 4693.694909830884, 4698.412698412699, 7245.130584329914, 7250.564966102051, 7274.199838017814, 7312.9396237546325, 7327.9267207327775, 4716.0, 4759.547842954914, 4763.2140696784645, 4771.141194584939, 4772.665913386099, 4833.758312084382, 4841.661083724105, 4844.370231869905, 4847.709137451764, 4853.247746599282, 5675.0, 5691.0, 5692.174634677948, 5694.316681998187, 5705.429457054262, 6844.965775171092, 6996.125484314461, 7020.333068358498, 7028.753993610199, 7062.258462861429, 1666.3334666133644, 1677.337451706569, 1685.9157042147845, 1691.0023086379094, 1692.4499537650313, 1027.106417416852, 1045.3936716704293, 1060.81966065769, 1073.7423018475665, 1074.1031238915436, 6660.467162626978, 6868.484863635247, 6909.654517274217, 6910.44716422685, 6944.756933507303, 7277.0, 7281.708731650675, 7283.0, 7303.598302093435, 7311.488195826241, 6876.140482439695, 6884.759033433906, 6896.551724137915, 6903.344182302673, 6907.067545881342, 3871.825767840454, 3875.903102422462, 3917.5103112110987, 3939.054626889526, 3946.3488524393156, 7673.34776544, 7675.692972281158, 7680.769576912701, 7688.769336919901, 7690.384769218449, 7421.962890185515, 7431.071116110486, 7465.104187497426, 7473.4021278297605, 7474.514156579805, 7604.80987975294, 7667.156612772591, 7678.5392876427595, 7686.192949740309, 7687.5387476751575, 7058.153021637437, 7262.055932728711, 7269.745558905624, 7279.5268307561955, 7281.05346304977, 7153.678084486315, 7171.713131474683, 7178.60517671533, 7186.964065179641, 7191.208967013729, 7664.616769161408, 7679.731209407644, 7680.385569154342, 7683.231676832272, 7689.115751688628, 4643.814247430065, 4648.93026604608, 4680.438347398334, 4681.368015317888, 4698.130845793539, 7064.646767661699, 7201.567905925661, 7234.710611575478, 7249.528780629243, 7257.346838784323, 6984.3364880336285, 6998.230194678683, 6999.475039371966, 7005.929940700527, 7032.472564557576, 6988.440924726111, 6991.545549539263, 6992.300769922967, 7014.123234595676, 7019.929800701928, 6857.657117144223, 6890.552114112566, 6902.792916212522, 6912.827179320558, 6917.0, 6799.830004249933, 7009.859802804018, 7073.3987611053635, 7075.858482830417, 7093.858122837618, 6766.492513061442, 6924.549904256207, 6925.0, 6938.861222775416, 6939.4795390346935], "value": 5208.720058126901, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [816.4448175240838, 861.3410740783298, 913.4701872913711, 918.3204428722745, 924.2328867040358, 13807.792883106762, 13887.0, 14160.433582656708, 14409.71180576389, 14589.781153282709, 13416.195028298285, 13453.260070696108, 13458.990575706837, 13460.326983650803, 13488.460461581524, 757.5530437042157, 904.0, 917.1424717888762, 923.5290002098944, 924.9583768730423, 914.5792935249793, 916.1937495004387, 918.0910898210757, 919.6873063158524, 920.3649481857497, 970.4129001953822, 972.1348000279756, 973.7419583810296, 974.9463779492125, 976.9120779129877, 961.1493827962269, 962.3263715399214, 964.0455948610895, 967.738710548155, 970.4856426094182, 716.4304378019435, 717.125107369009, 717.4834119433999, 719.1083057009323, 719.3238355945447, 13985.0, 13994.580162595139, 14022.088564243291, 14034.508792192326, 14047.78928316076, 15434.922825385913, 15455.92272038644, 15562.0, 15692.215389230607, 15731.0, 12398.81401778974, 12462.81305780414, 12557.0, 12607.306598137098, 12715.809262861065, 3965.7025723070883, 3982.7411218270718, 4036.0717035082093, 4037.4953130858644, 4155.750654960712, 56237.0, 56514.71742641261, 56839.71580142073, 56914.0, 56979.43020569783, 11703.414829258674, 12212.511499540096, 12220.816687749691, 12343.567975121006, 12359.876401236052, 21838.23566175176, 21841.890790546262, 21881.234156804436, 21949.122035118417, 22077.33767986963, 8851.734447966572, 8860.86708699357, 8873.334499912533, 8932.598033088527, 8961.955190224007, 4878.121938051114, 5028.874278143076, 5059.595232381401, 5083.364579427572, 5121.9743901281, 3597.082743900341, 3651.634836516327, 3655.908602284911, 3663.743537952371, 3665.52348194733, 629.3769168523221, 646.9870602587922, 653.411929263657, 660.8876490996446, 664.0703015777949, 686.4851361478891, 757.9052618422697, 766.6435107674957, 769.3076231391792, 780.9648565814553, 9903.504824758733, 9905.306628536078, 10108.646197383203, 10125.898741012643, 10415.0, 718.8634159509677, 754.6792613139394, 777.3004296133525, 796.5618909599697, 823.320760372695, 4525.256550762193, 4649.163150632851, 4656.4877863434995, 4668.5564871337165, 4673.0, 64393.67803160954, 64546.0, 65832.0, 65844.0, 65989.67005165039, 60763.0, 61538.38461615416, 62084.37915620786, 62629.68685156636, 63510.0, 57733.42266577364, 58426.41573584295, 59570.70214648899, 60238.0, 60710.69644651748, 9841.901580984098, 10032.448215348226, 10187.796244074929, 10255.897441025494, 10330.276880618285, 38162.045948851504, 38769.0, 41361.58638413698, 41481.58518414777, 42922.14155716931, 47151.0, 53933.46066539284, 54334.641633959465, 54598.454015459334, 55191.41255818359, 13004.8049279259, 13057.02072344559, 13277.336133193108, 13554.186748795104, 13601.931990339985, 14538.127712337293, 14610.926945365205, 14666.413343466142, 14851.777223341875, 14933.701325973638, 13505.392257348247, 13563.525276615272, 13666.248356340497, 13880.305984700522, 13897.791533126809, 13608.93195534016, 13747.862521374658, 13788.0, 14009.299535023005, 14476.059056161315, 13199.802002969771, 13514.526991555642, 13704.52034178799, 14003.509877154658, 14083.295835208404, 11359.659210223706, 11768.176227664324, 11769.823452648046, 11991.460384282555, 12117.27296362221, 11168.944155279496, 11201.551937922392, 11455.312681239153, 11512.251703639236, 11663.125265605284], "value": 7362.622315359596, "unit": "score"}], "name": "dromaeo_css", "value": 7567.285591039097, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 111.0, 104.0, 113.0, 111.0, 115.0, 101.0, 109.0, 110.0, 110.0], "value": 109.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 130.0, 162.0, 183.0, 129.0, 161.0, 155.0, 129.0, 182.0, 129.0], "value": 152.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 165.0, 164.0, 163.0, 163.0, 163.0, 163.0, 164.0, 164.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 74.0, 77.0, 169.0, 77.0, 76.0, 76.0, 76.0, 156.0, 77.0], "value": 93.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 94.0, 149.0, 92.0, 93.0, 92.0, 159.0, 93.0, 93.0, 159.0], "value": 111.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 146.0, 147.0, 154.0, 147.0, 146.0, 147.0, 146.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 97.0, 95.0, 95.0, 95.0, 95.0, 100.0, 95.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 56.0, 54.0, 55.0, 57.0, 60.0, 55.0, 77.0, 54.0, 56.0], "value": 57.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 59.0, 59.0, 60.0, 58.0, 58.0, 59.0, 60.0, 60.0], "value": 59.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 75.0, 72.0, 72.0, 80.0, 74.0, 74.0, 76.0, 75.0], "value": 74.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 117.0, 121.0, 117.0, 118.0, 114.0, 116.0, 131.0, 135.0], "value": 119.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 157.0, 158.0, 167.0, 160.0, 166.0, 157.0, 160.0, 164.0, 162.0], "value": 161.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 68.0, 66.0, 66.0, 64.0, 65.0, 66.0, 64.0, 65.0], "value": 65.8, "unit": "score"}], "name": "kraken", "value": 1529.9, "alertThreshold": 2.0}]} 05:31:22 INFO - Return code: 0 05:31:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:31:23 ERROR - # TBPL SUCCESS # 05:31:23 INFO - Running post-action listener: _resource_record_post_action 05:31:23 INFO - Running post-run listener: _resource_record_post_run 05:31:24 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 504320000; Read time: 4; Write time: 1414016 05:31:24 INFO - install - Wall time: 16s; CPU: 20.0%; Read bytes: 0; Write bytes: 261660672; Read time: 0; Write time: 1023616 05:31:24 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 242061312; Read time: 4; Write time: 390140 05:31:24 INFO - Running post-run listener: _upload_blobber_files 05:31:24 INFO - Blob upload gear active. 05:31:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:31:24 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 05:31:24 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'] 05:31:24 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 05:31:24 INFO - (blobuploader) - INFO - Open directory for files ... 05:31:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:31:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:31:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:31:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:31:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:31:25 INFO - (blobuploader) - INFO - Done attempting. 05:31:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:31:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:31:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:31:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:31:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:31:26 INFO - (blobuploader) - INFO - Done attempting. 05:31:26 INFO - (blobuploader) - INFO - Iteration through files over. 05:31:26 INFO - Return code: 0 05:31:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:31:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:31:26 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/51d0bdf27b370032e51026d5b28d25f94c3217d56e0c7d6bee8ee1c7ca7b1b31b83fbdc2a7553a2c4209f6746c9d41e5f14fc57ac06dbe9012671f8a531ddf13", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/16c3616d0733fbc9cb6cd10f3915ffe850727b395bb912addd1518e90d6811a8ebeb285188e03b2b2a9a1b520a600dff2cf6fb8e9be33dd93cbb98b2c0187fa0"} 05:31:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:31:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:31:26 INFO - Contents: 05:31:26 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/51d0bdf27b370032e51026d5b28d25f94c3217d56e0c7d6bee8ee1c7ca7b1b31b83fbdc2a7553a2c4209f6746c9d41e5f14fc57ac06dbe9012671f8a531ddf13", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/16c3616d0733fbc9cb6cd10f3915ffe850727b395bb912addd1518e90d6811a8ebeb285188e03b2b2a9a1b520a600dff2cf6fb8e9be33dd93cbb98b2c0187fa0"} 05:31:26 INFO - Running post-run listener: copy_logs_to_upload_dir 05:31:26 INFO - Copying logs to upload dir... 05:31:26 INFO - mkdir: /builds/slave/test/build/upload/logs 05:31:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1228.887616 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-06-01 05:31:25.993728) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-01 05:31:25.996888) ========= 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=df17445c3590ff7897617a0e00000225-1464783055.605947-1892751329 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/51d0bdf27b370032e51026d5b28d25f94c3217d56e0c7d6bee8ee1c7ca7b1b31b83fbdc2a7553a2c4209f6746c9d41e5f14fc57ac06dbe9012671f8a531ddf13", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/16c3616d0733fbc9cb6cd10f3915ffe850727b395bb912addd1518e90d6811a8ebeb285188e03b2b2a9a1b520a600dff2cf6fb8e9be33dd93cbb98b2c0187fa0"} build_url:https://queue.taskcluster.net/v1/task/ERN1Yn6ITHyyQBFQTaiReg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011274 build_url: 'https://queue.taskcluster.net/v1/task/ERN1Yn6ITHyyQBFQTaiReg/artifacts/public/build/firefox-48.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/51d0bdf27b370032e51026d5b28d25f94c3217d56e0c7d6bee8ee1c7ca7b1b31b83fbdc2a7553a2c4209f6746c9d41e5f14fc57ac06dbe9012671f8a531ddf13", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/16c3616d0733fbc9cb6cd10f3915ffe850727b395bb912addd1518e90d6811a8ebeb285188e03b2b2a9a1b520a600dff2cf6fb8e9be33dd93cbb98b2c0187fa0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-01 05:31:26.023482) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 05:31:26.023844) ========= 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=df17445c3590ff7897617a0e00000225-1464783055.605947-1892751329 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004611 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 05:31:26.106522) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-01 05:31:26.106834) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-01 05:31:26.107111) ========= ========= Total master_lag: 0.17 =========