builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-004 starttime: 1464014594.11 results: success (0) buildid: 20160523045840 builduid: 5d17ee22c9514600b3088f7d0899801d revision: ad804098d30c0b227c73e344c9addd9e5a7c3e09 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-23 07:43:14.112058) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-23 07:43:14.112424) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-23 07:43:14.112734) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-23 07:43:14.148374) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 07:43:14.148640) ========= 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=c6927cf182745ad25b1d38b9000001fe-1464008973.203001-1874161468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-23 07:43:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 70.9M=0s 2016-05-23 07:43:15 (70.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.104993 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 07:43:14.267143) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 07:43:14.267419) ========= 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=c6927cf182745ad25b1d38b9000001fe-1464008973.203001-1874161468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014037 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 07:43:14.315832) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 07:43:14.316148) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ad804098d30c0b227c73e344c9addd9e5a7c3e09 --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 ad804098d30c0b227c73e344c9addd9e5a7c3e09 --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=c6927cf182745ad25b1d38b9000001fe-1464008973.203001-1874161468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-23 07:43:15,596 truncating revision to first 12 chars 2016-05-23 07:43:15,596 Setting DEBUG logging. 2016-05-23 07:43:15,596 attempt 1/10 2016-05-23 07:43:15,597 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/ad804098d30c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-23 07:43:15,891 unpacking tar archive at: mozilla-aurora-ad804098d30c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.578313 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 07:43:14.911374) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-23 07:43:14.911676) ========= script_repo_revision: ad804098d30c0b227c73e344c9addd9e5a7c3e09 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-23 07:43:14.912036) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-23 07:43:14.912306) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-23 07:43:14.930319) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-05-23 07:43:14.930599) ========= /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=c6927cf182745ad25b1d38b9000001fe-1464008973.203001-1874161468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:43:16 INFO - MultiFileLogger online at 20160523 07:43:16 in /builds/slave/test 07:43:16 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 07:43:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:43:16 INFO - {'append_to_log': False, 07:43:16 INFO - 'base_work_dir': '/builds/slave/test', 07:43:16 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:43:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:43:16 INFO - 'branch': 'Mozilla-Aurora', 07:43:16 INFO - 'buildbot_json_path': 'buildprops.json', 07:43:16 INFO - 'config_files': ('talos/linux_config.py',), 07:43:16 INFO - 'default_actions': ('clobber', 07:43:16 INFO - 'read-buildbot-config', 07:43:16 INFO - 'download-and-extract', 07:43:16 INFO - 'populate-webroot', 07:43:16 INFO - 'create-virtualenv', 07:43:16 INFO - 'install', 07:43:16 INFO - 'run-tests'), 07:43:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:43:16 INFO - 'download_minidump_stackwalk': True, 07:43:16 INFO - 'download_symbols': 'ondemand', 07:43:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:43:16 INFO - 'tooltool.py': '/tools/tooltool.py', 07:43:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:43:16 INFO - '/tools/misc-python/virtualenv.py')}, 07:43:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:43:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:43:16 INFO - 'installer_path': 'installer.exe', 07:43:16 INFO - 'log_level': 'info', 07:43:16 INFO - 'log_name': 'talos', 07:43:16 INFO - 'log_to_console': True, 07:43:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:43:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:43:16 INFO - 'opt_config_files': (), 07:43:16 INFO - 'pip_index': False, 07:43:16 INFO - 'sps_profile': False, 07:43:16 INFO - 'sps_profile_interval': 0, 07:43:16 INFO - 'suite': 'dromaeojs-e10s', 07:43:16 INFO - 'system_bits': '32', 07:43:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:43:16 INFO - 'title': 'talos-linux64-ix-004', 07:43:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:43:16 INFO - 'use_talos_json': True, 07:43:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:43:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:43:16 INFO - 'work_dir': 'build'} 07:43:16 INFO - ##### 07:43:16 INFO - ##### Running clobber step. 07:43:16 INFO - ##### 07:43:16 INFO - Running pre-action listener: _resource_record_pre_action 07:43:16 INFO - Running main action method: clobber 07:43:16 INFO - rmtree: /builds/slave/test/build 07:43:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:43:16 INFO - Running post-action listener: _resource_record_post_action 07:43:16 INFO - ##### 07:43:16 INFO - ##### Running read-buildbot-config step. 07:43:16 INFO - ##### 07:43:16 INFO - Running pre-action listener: _resource_record_pre_action 07:43:16 INFO - Running main action method: read_buildbot_config 07:43:16 INFO - Using buildbot properties: 07:43:16 INFO - { 07:43:16 INFO - "project": "", 07:43:16 INFO - "product": "firefox", 07:43:16 INFO - "script_repo_revision": "production", 07:43:16 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 07:43:16 INFO - "repository": "", 07:43:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 07:43:16 INFO - "buildid": "20160523045840", 07:43:16 INFO - "pgo_build": "True", 07:43:16 INFO - "basedir": "/builds/slave/test", 07:43:16 INFO - "buildnumber": 329, 07:43:16 INFO - "slavename": "talos-linux64-ix-004", 07:43:16 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:43:16 INFO - "platform": "ubuntu64_hw", 07:43:16 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 07:43:16 INFO - "branch": "mozilla-aurora", 07:43:16 INFO - "repo_path": "releases/mozilla-aurora", 07:43:16 INFO - "revision": "ad804098d30c0b227c73e344c9addd9e5a7c3e09", 07:43:16 INFO - "stage_platform": "linux64-pgo", 07:43:16 INFO - "builduid": "5d17ee22c9514600b3088f7d0899801d", 07:43:16 INFO - "slavebuilddir": "test" 07:43:16 INFO - } 07:43:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/RGErAEGHSFmeSM9oVvVPCQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 07:43:16 INFO - Running post-action listener: _resource_record_post_action 07:43:16 INFO - ##### 07:43:16 INFO - ##### Running download-and-extract step. 07:43:16 INFO - ##### 07:43:16 INFO - Running pre-action listener: _resource_record_pre_action 07:43:16 INFO - Running main action method: download_and_extract 07:43:16 INFO - mkdir: /builds/slave/test/build/tests 07:43:16 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')]} 07:43:16 INFO - https://queue.taskcluster.net/v1/task/RGErAEGHSFmeSM9oVvVPCQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:43:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGErAEGHSFmeSM9oVvVPCQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 07:43:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGErAEGHSFmeSM9oVvVPCQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 07:43:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGErAEGHSFmeSM9oVvVPCQ/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 07:43:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGErAEGHSFmeSM9oVvVPCQ/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 07:43:27 INFO - Downloaded 1361 bytes. 07:43:27 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 07:43:27 INFO - Using the following test package requirements: 07:43:27 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 07:43:27 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 07:43:27 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 07:43:27 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 07:43:27 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 07:43:27 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 07:43:27 INFO - u'jsshell-linux-x86_64.zip'], 07:43:27 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 07:43:27 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 07:43:27 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 07:43:27 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 07:43:27 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 07:43:27 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 07:43:27 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 07:43:27 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 07:43:27 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 07:43:27 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 07:43:27 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 07:43:27 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:43:27 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')]} 07:43:27 INFO - https://queue.taskcluster.net/v1/task/RGErAEGHSFmeSM9oVvVPCQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:43:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGErAEGHSFmeSM9oVvVPCQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 07:43:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGErAEGHSFmeSM9oVvVPCQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 07:43:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGErAEGHSFmeSM9oVvVPCQ/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 07:43:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGErAEGHSFmeSM9oVvVPCQ/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 07:43:39 INFO - Downloaded 23812944 bytes. 07:43:39 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'] 07:43:39 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 07:43:40 INFO - Return code: 0 07:43:40 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 07:43:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:43:40 INFO - https://queue.taskcluster.net/v1/task/RGErAEGHSFmeSM9oVvVPCQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:43:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGErAEGHSFmeSM9oVvVPCQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 07:43:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGErAEGHSFmeSM9oVvVPCQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 07:43:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGErAEGHSFmeSM9oVvVPCQ/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 07:43:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGErAEGHSFmeSM9oVvVPCQ/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 07:43:41 INFO - Downloaded 23812944 bytes. 07:43:41 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'] 07:43:41 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 07:43:43 INFO - Return code: 0 07:43:43 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')]} 07:43:43 INFO - https://queue.taskcluster.net/v1/task/RGErAEGHSFmeSM9oVvVPCQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:43:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGErAEGHSFmeSM9oVvVPCQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 07:43:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGErAEGHSFmeSM9oVvVPCQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 07:43:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGErAEGHSFmeSM9oVvVPCQ/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 07:43:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGErAEGHSFmeSM9oVvVPCQ/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 07:43:44 INFO - Downloaded 10840145 bytes. 07:43:44 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'] 07:43:44 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 07:43:44 INFO - Return code: 0 07:43:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:43:44 INFO - https://queue.taskcluster.net/v1/task/RGErAEGHSFmeSM9oVvVPCQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:43:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGErAEGHSFmeSM9oVvVPCQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 07:43:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGErAEGHSFmeSM9oVvVPCQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 07:43:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGErAEGHSFmeSM9oVvVPCQ/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 07:43:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGErAEGHSFmeSM9oVvVPCQ/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 07:43:46 INFO - Downloaded 62732482 bytes. 07:43:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RGErAEGHSFmeSM9oVvVPCQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 07:43:46 INFO - mkdir: /builds/slave/test/properties 07:43:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:43:46 INFO - Writing to file /builds/slave/test/properties/build_url 07:43:46 INFO - Contents: 07:43:46 INFO - build_url:https://queue.taskcluster.net/v1/task/RGErAEGHSFmeSM9oVvVPCQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 07:43:47 INFO - Running post-action listener: _resource_record_post_action 07:43:47 INFO - Running post-action listener: set_extra_try_arguments 07:43:47 INFO - ##### 07:43:47 INFO - ##### Running populate-webroot step. 07:43:47 INFO - ##### 07:43:47 INFO - Running pre-action listener: _resource_record_pre_action 07:43:47 INFO - Running main action method: populate_webroot 07:43:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:43:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:43:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:43:47 INFO - '--tppagecycles', 07:43:47 INFO - '7'], 07:43:47 INFO - 'tests': ['tsvgm']}}, 07:43:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:43:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:43:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:43:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:43:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:43:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:43:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:43:47 INFO - 'talos_options': ['--disable-e10s'], 07:43:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:43:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:43:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:43:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:43:47 INFO - 'talos_options': ['--disable-e10s'], 07:43:47 INFO - 'tests': ['damp', 'tps']}, 07:43:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:43:47 INFO - 'tests': ['damp', 'tps']}, 07:43:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:43:47 INFO - 'tests': ['dromaeo_dom']}, 07:43:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:43:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:43:47 INFO - 'tests': ['a11yr', 07:43:47 INFO - 'ts_paint', 07:43:47 INFO - 'tpaint', 07:43:47 INFO - 'sessionrestore', 07:43:47 INFO - 'sessionrestore_no_auto_restore', 07:43:47 INFO - 'tabpaint']}, 07:43:47 INFO - 'other-e10s': {'tests': ['a11yr', 07:43:47 INFO - 'ts_paint', 07:43:47 INFO - 'tpaint', 07:43:47 INFO - 'sessionrestore', 07:43:47 INFO - 'sessionrestore_no_auto_restore', 07:43:47 INFO - 'tabpaint']}, 07:43:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:43:47 INFO - 'ts_paint', 07:43:47 INFO - 'tpaint', 07:43:47 INFO - 'sessionrestore', 07:43:47 INFO - 'sessionrestore_no_auto_restore', 07:43:47 INFO - 'tabpaint']}, 07:43:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:43:47 INFO - 'ts_paint', 07:43:47 INFO - 'tpaint', 07:43:47 INFO - 'sessionrestore', 07:43:47 INFO - 'sessionrestore_no_auto_restore', 07:43:47 INFO - 'tabpaint']}, 07:43:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:43:47 INFO - 'tests': ['a11yr', 07:43:47 INFO - 'ts_paint', 07:43:47 INFO - 'tpaint', 07:43:47 INFO - 'sessionrestore', 07:43:47 INFO - 'sessionrestore_no_auto_restore', 07:43:47 INFO - 'tabpaint']}, 07:43:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:43:47 INFO - 'tests': ['a11yr', 07:43:47 INFO - 'ts_paint', 07:43:47 INFO - 'tpaint', 07:43:47 INFO - 'sessionrestore', 07:43:47 INFO - 'sessionrestore_no_auto_restore', 07:43:47 INFO - 'tabpaint']}, 07:43:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:43:47 INFO - 'tests': ['tsvgx', 07:43:47 INFO - 'tsvgr_opacity', 07:43:47 INFO - 'tart', 07:43:47 INFO - 'tscrollx', 07:43:47 INFO - 'cart']}, 07:43:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:43:47 INFO - 'tsvgr_opacity', 07:43:47 INFO - 'tart', 07:43:47 INFO - 'tscrollx', 07:43:47 INFO - 'cart']}, 07:43:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:43:47 INFO - 'talos_options': ['--disable-e10s'], 07:43:47 INFO - 'tests': ['tp5o']}, 07:43:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:43:47 INFO - 'tests': ['tp5o']}, 07:43:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:43:47 INFO - 'talos_options': ['--disable-e10s', 07:43:47 INFO - '--xperf_path', 07:43:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:43:47 INFO - 'tests': ['tp5n']}, 07:43:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:43:47 INFO - 'talos_options': ['--xperf_path', 07:43:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:43:47 INFO - 'tests': ['tp5n']}}, 07:43:47 INFO - 'talos.zip': {'path': '', 07:43:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:43:47 INFO - Running post-action listener: _resource_record_post_action 07:43:47 INFO - ##### 07:43:47 INFO - ##### Running create-virtualenv step. 07:43:47 INFO - ##### 07:43:47 INFO - Running pre-action listener: _resource_record_pre_action 07:43:47 INFO - Running main action method: create_virtualenv 07:43:47 INFO - Creating virtualenv /builds/slave/test/build/venv 07:43:47 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 07:43:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:43:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:43:47 INFO - Using real prefix '/usr' 07:43:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:43:48 INFO - Installing distribute.............................................................................................................................................................................................done. 07:43:50 INFO - Installing pip.................done. 07:43:50 INFO - Return code: 0 07:43:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:43: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')]} 07:43:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43: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')]} 07:43:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f524f74cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf2a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb9410>, '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 0xfba310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfba7a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1464008973.203001-1874161468', '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 07:43:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:43:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:43:50 INFO - Using env: {'DISPLAY': ':0', 07:43:50 INFO - 'HOME': '/home/cltbld', 07:43:50 INFO - 'LANG': 'en_US.UTF-8', 07:43:50 INFO - 'LANGUAGE': 'en_US:en', 07:43:50 INFO - 'LOGNAME': 'cltbld', 07:43:50 INFO - 'MAIL': '/var/mail/cltbld', 07:43:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:50 INFO - 'MOZ_NO_REMOTE': '1', 07:43:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:43:50 INFO - 'NO_EM_RESTART': '1', 07:43:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:43:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:50 INFO - 'PWD': '/builds/slave/test', 07:43:50 INFO - 'SHELL': '/bin/bash', 07:43:50 INFO - 'SHLVL': '1', 07:43:50 INFO - 'TERM': 'linux', 07:43:50 INFO - 'TMOUT': '86400', 07:43:50 INFO - 'USER': 'cltbld', 07:43:50 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1464008973.203001-1874161468', 07:43:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:50 INFO - '_': '/tools/buildbot/bin/python'} 07:43:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:43:50 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 07:43:50 INFO - Cleaning up... 07:43:50 INFO - Return code: 0 07:43:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:43: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')]} 07:43:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43: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')]} 07:43:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f524f74cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf2a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb9410>, '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 0xfba310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfba7a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1464008973.203001-1874161468', '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 07:43:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 07:43:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 07:43:50 INFO - Using env: {'DISPLAY': ':0', 07:43:50 INFO - 'HOME': '/home/cltbld', 07:43:50 INFO - 'LANG': 'en_US.UTF-8', 07:43:50 INFO - 'LANGUAGE': 'en_US:en', 07:43:50 INFO - 'LOGNAME': 'cltbld', 07:43:50 INFO - 'MAIL': '/var/mail/cltbld', 07:43:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:50 INFO - 'MOZ_NO_REMOTE': '1', 07:43:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:43:50 INFO - 'NO_EM_RESTART': '1', 07:43:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:43:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:50 INFO - 'PWD': '/builds/slave/test', 07:43:50 INFO - 'SHELL': '/bin/bash', 07:43:50 INFO - 'SHLVL': '1', 07:43:50 INFO - 'TERM': 'linux', 07:43:50 INFO - 'TMOUT': '86400', 07:43:50 INFO - 'USER': 'cltbld', 07:43:50 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1464008973.203001-1874161468', 07:43:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:50 INFO - '_': '/tools/buildbot/bin/python'} 07:43:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:43:50 INFO - Downloading/unpacking psutil>=0.7.1 07:43:50 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 07:43:50 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 07:43:50 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 07:43:50 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 07:43:50 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 07:43:50 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 07:43:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:43:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:43:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:43:52 INFO - Installing collected packages: psutil 07:43:52 INFO - Running setup.py install for psutil 07:43:52 INFO - building 'psutil._psutil_linux' extension 07:43:52 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 07:43:52 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 07:43:52 INFO - building 'psutil._psutil_posix' extension 07:43:52 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 07:43:53 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 07:43:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:43:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:43:53 INFO - Successfully installed psutil 07:43:53 INFO - Cleaning up... 07:43:53 INFO - Return code: 0 07:43:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:43:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:43:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:43:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f524f74cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf2a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb9410>, '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 0xfba310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfba7a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1464008973.203001-1874161468', '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 07:43:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 07:43:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 07:43:53 INFO - Using env: {'DISPLAY': ':0', 07:43:53 INFO - 'HOME': '/home/cltbld', 07:43:53 INFO - 'LANG': 'en_US.UTF-8', 07:43:53 INFO - 'LANGUAGE': 'en_US:en', 07:43:53 INFO - 'LOGNAME': 'cltbld', 07:43:53 INFO - 'MAIL': '/var/mail/cltbld', 07:43:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:53 INFO - 'MOZ_NO_REMOTE': '1', 07:43:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:43:53 INFO - 'NO_EM_RESTART': '1', 07:43:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:43:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:53 INFO - 'PWD': '/builds/slave/test', 07:43:53 INFO - 'SHELL': '/bin/bash', 07:43:53 INFO - 'SHLVL': '1', 07:43:53 INFO - 'TERM': 'linux', 07:43:53 INFO - 'TMOUT': '86400', 07:43:53 INFO - 'USER': 'cltbld', 07:43:53 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1464008973.203001-1874161468', 07:43:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:53 INFO - '_': '/tools/buildbot/bin/python'} 07:43:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:43:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:43:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:43:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:43:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:43:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:43:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:43:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:43:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:43:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:43:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:43:55 INFO - Installing collected packages: mozsystemmonitor 07:43:55 INFO - Running setup.py install for mozsystemmonitor 07:43:55 INFO - Successfully installed mozsystemmonitor 07:43:55 INFO - Cleaning up... 07:43:55 INFO - Return code: 0 07:43:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:43:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:43:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:43:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:55 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 0x7f524f74cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf2a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb9410>, '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 0xfba310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfba7a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1464008973.203001-1874161468', '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 07:43:55 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 07:43:55 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 07:43:55 INFO - Using env: {'DISPLAY': ':0', 07:43:55 INFO - 'HOME': '/home/cltbld', 07:43:55 INFO - 'LANG': 'en_US.UTF-8', 07:43:55 INFO - 'LANGUAGE': 'en_US:en', 07:43:55 INFO - 'LOGNAME': 'cltbld', 07:43:55 INFO - 'MAIL': '/var/mail/cltbld', 07:43:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:55 INFO - 'MOZ_NO_REMOTE': '1', 07:43:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:43:55 INFO - 'NO_EM_RESTART': '1', 07:43:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:43:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:55 INFO - 'PWD': '/builds/slave/test', 07:43:55 INFO - 'SHELL': '/bin/bash', 07:43:55 INFO - 'SHLVL': '1', 07:43:55 INFO - 'TERM': 'linux', 07:43:55 INFO - 'TMOUT': '86400', 07:43:55 INFO - 'USER': 'cltbld', 07:43:55 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1464008973.203001-1874161468', 07:43:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:55 INFO - '_': '/tools/buildbot/bin/python'} 07:43:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:43:55 INFO - Downloading/unpacking blobuploader==1.2.4 07:43:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:43:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:43:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:43:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:43:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:43:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:43:57 INFO - Downloading blobuploader-1.2.4.tar.gz 07:43:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:43:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:43:57 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 07:43:57 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 07:43:57 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 07:43:57 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 07:43:57 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 07:43:57 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 07:43:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:43:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:43:58 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 07:43:58 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 07:43:58 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 07:43:58 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 07:43:58 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 07:43:58 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 07:43:58 INFO - Downloading docopt-0.6.1.tar.gz 07:43:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:43:58 INFO - Installing collected packages: blobuploader, requests, docopt 07:43:58 INFO - Running setup.py install for blobuploader 07:43:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:43:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:43:58 INFO - Running setup.py install for requests 07:43:58 INFO - Running setup.py install for docopt 07:43:59 INFO - Successfully installed blobuploader requests docopt 07:43:59 INFO - Cleaning up... 07:43:59 INFO - Return code: 0 07:43:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:43:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:43:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:43:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:59 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 0x7f524f74cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf2a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb9410>, '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 0xfba310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfba7a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1464008973.203001-1874161468', '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 07:43:59 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 07:43:59 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 07:43:59 INFO - Using env: {'DISPLAY': ':0', 07:43:59 INFO - 'HOME': '/home/cltbld', 07:43:59 INFO - 'LANG': 'en_US.UTF-8', 07:43:59 INFO - 'LANGUAGE': 'en_US:en', 07:43:59 INFO - 'LOGNAME': 'cltbld', 07:43:59 INFO - 'MAIL': '/var/mail/cltbld', 07:43:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:59 INFO - 'MOZ_NO_REMOTE': '1', 07:43:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:43:59 INFO - 'NO_EM_RESTART': '1', 07:43:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:43:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:59 INFO - 'PWD': '/builds/slave/test', 07:43:59 INFO - 'SHELL': '/bin/bash', 07:43:59 INFO - 'SHLVL': '1', 07:43:59 INFO - 'TERM': 'linux', 07:43:59 INFO - 'TMOUT': '86400', 07:43:59 INFO - 'USER': 'cltbld', 07:43:59 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1464008973.203001-1874161468', 07:43:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:59 INFO - '_': '/tools/buildbot/bin/python'} 07:43:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:43:59 INFO - Running setup.py (path:/tmp/pip-QEIbrO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:43:59 INFO - Running setup.py (path:/tmp/pip-tkgerw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:43:59 INFO - Running setup.py (path:/tmp/pip-bzDNfy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:43:59 INFO - Running setup.py (path:/tmp/pip-SsYmAz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:43:59 INFO - Running setup.py (path:/tmp/pip-hX6SlA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:43:59 INFO - Running setup.py (path:/tmp/pip-oAV_Gn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:43:59 INFO - Running setup.py (path:/tmp/pip-vdBrm4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:43:59 INFO - Running setup.py (path:/tmp/pip-2nWlkN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:43:59 INFO - Running setup.py (path:/tmp/pip-AGVNV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:43:59 INFO - Running setup.py (path:/tmp/pip-60surD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:44:00 INFO - Running setup.py (path:/tmp/pip-Dzfo5A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:44:00 INFO - Running setup.py (path:/tmp/pip-vnFOWy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:44:00 INFO - Running setup.py (path:/tmp/pip-BRhwwG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:44:00 INFO - Running setup.py (path:/tmp/pip-sCIIu4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:44:00 INFO - Running setup.py (path:/tmp/pip-DNYC0T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:44:00 INFO - Running setup.py (path:/tmp/pip-LcuIes-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:44:00 INFO - Running setup.py (path:/tmp/pip-Jnda8v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:44:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:44:00 INFO - Running setup.py install for manifestparser 07:44:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:44:00 INFO - Running setup.py install for mozcrash 07:44:00 INFO - Running setup.py install for mozdebug 07:44:00 INFO - Running setup.py install for mozdevice 07:44:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:44:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:44:00 INFO - Running setup.py install for mozfile 07:44:01 INFO - Running setup.py install for mozhttpd 07:44:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:44:01 INFO - Running setup.py install for mozinfo 07:44:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:44:01 INFO - Running setup.py install for mozInstall 07:44:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:44:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:44:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:44:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:44:01 INFO - Running setup.py install for mozleak 07:44:01 INFO - Running setup.py install for mozlog 07:44:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:44:01 INFO - Running setup.py install for moznetwork 07:44:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:44:01 INFO - Running setup.py install for mozprocess 07:44:01 INFO - Running setup.py install for mozprofile 07:44:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:44:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:44:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:44:01 INFO - Running setup.py install for mozrunner 07:44:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:44:02 INFO - Running setup.py install for mozscreenshot 07:44:02 INFO - Running setup.py install for moztest 07:44:02 INFO - Running setup.py install for mozversion 07:44:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:44:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:44:02 INFO - Cleaning up... 07:44:02 INFO - Return code: 0 07:44:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:44:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:02 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 0x7f524f74cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf2a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb9410>, '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 0xfba310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfba7a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1464008973.203001-1874161468', '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 07:44:02 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 07:44:02 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 07:44:02 INFO - Using env: {'DISPLAY': ':0', 07:44:02 INFO - 'HOME': '/home/cltbld', 07:44:02 INFO - 'LANG': 'en_US.UTF-8', 07:44:02 INFO - 'LANGUAGE': 'en_US:en', 07:44:02 INFO - 'LOGNAME': 'cltbld', 07:44:02 INFO - 'MAIL': '/var/mail/cltbld', 07:44:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:02 INFO - 'MOZ_NO_REMOTE': '1', 07:44:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:02 INFO - 'NO_EM_RESTART': '1', 07:44:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:02 INFO - 'PWD': '/builds/slave/test', 07:44:02 INFO - 'SHELL': '/bin/bash', 07:44:02 INFO - 'SHLVL': '1', 07:44:02 INFO - 'TERM': 'linux', 07:44:02 INFO - 'TMOUT': '86400', 07:44:02 INFO - 'USER': 'cltbld', 07:44:02 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1464008973.203001-1874161468', 07:44:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:02 INFO - '_': '/tools/buildbot/bin/python'} 07:44:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:44:02 INFO - Running setup.py (path:/tmp/pip-J5Jwo1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:44:02 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)) 07:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:44:02 INFO - Running setup.py (path:/tmp/pip-6X42sJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:44:02 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)) 07:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:44:02 INFO - Running setup.py (path:/tmp/pip-nhLYMj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:44:02 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)) 07:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:44:02 INFO - Running setup.py (path:/tmp/pip-x1TAPN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:44:02 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)) 07:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:44:02 INFO - Running setup.py (path:/tmp/pip-9n8N7S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:44:02 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)) 07:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:44:02 INFO - Running setup.py (path:/tmp/pip-R4XSfo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:44:03 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)) 07:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:44:03 INFO - Running setup.py (path:/tmp/pip-6b7O5L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:44:03 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)) 07:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:44:03 INFO - Running setup.py (path:/tmp/pip-WUzjkk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:44:03 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)) 07:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:44:03 INFO - Running setup.py (path:/tmp/pip-u0AvVu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:44:03 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)) 07:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:44:03 INFO - Running setup.py (path:/tmp/pip-ia4vtj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:44:03 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)) 07:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:44:03 INFO - Running setup.py (path:/tmp/pip-SYuTVs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:44:03 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)) 07:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:44:03 INFO - Running setup.py (path:/tmp/pip-mZEKS0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:44:03 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)) 07:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:44:03 INFO - Running setup.py (path:/tmp/pip-4A3kqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:44:03 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)) 07:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:44:03 INFO - Running setup.py (path:/tmp/pip-JwxWT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:44:03 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)) 07:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:44:03 INFO - Running setup.py (path:/tmp/pip-IwSwqm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:44:03 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)) 07:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:44:03 INFO - Running setup.py (path:/tmp/pip-BIRR4e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:44:03 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)) 07:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:44:03 INFO - Running setup.py (path:/tmp/pip-mCG5vE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:44:03 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)) 07:44:03 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)) 07:44:03 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)) 07:44:03 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)) 07:44:03 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)) 07:44:03 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)) 07:44:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:44:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:44:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:44:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:44:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:44:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:44:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:44:05 INFO - Downloading blessings-1.6.tar.gz 07:44:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:44:05 INFO - Installing collected packages: blessings 07:44:05 INFO - Running setup.py install for blessings 07:44:05 INFO - Successfully installed blessings 07:44:05 INFO - Cleaning up... 07:44:05 INFO - Return code: 0 07:44:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:44:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:44:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:44:06 INFO - Reading from file tmpfile_stdout 07:44:06 INFO - Current package versions: 07:44:06 INFO - argparse == 1.2.1 07:44:06 INFO - blessings == 1.6 07:44:06 INFO - blobuploader == 1.2.4 07:44:06 INFO - docopt == 0.6.1 07:44:06 INFO - manifestparser == 1.1 07:44:06 INFO - mozInstall == 1.12 07:44:06 INFO - mozcrash == 0.17 07:44:06 INFO - mozdebug == 0.1 07:44:06 INFO - mozdevice == 0.48 07:44:06 INFO - mozfile == 1.2 07:44:06 INFO - mozhttpd == 0.7 07:44:06 INFO - mozinfo == 0.9 07:44:06 INFO - mozleak == 0.1 07:44:06 INFO - mozlog == 3.1 07:44:06 INFO - moznetwork == 0.27 07:44:06 INFO - mozprocess == 0.22 07:44:06 INFO - mozprofile == 0.28 07:44:06 INFO - mozrunner == 6.11 07:44:06 INFO - mozscreenshot == 0.1 07:44:06 INFO - mozsystemmonitor == 0.0 07:44:06 INFO - moztest == 0.7 07:44:06 INFO - mozversion == 1.4 07:44:06 INFO - psutil == 3.1.1 07:44:06 INFO - requests == 1.2.3 07:44:06 INFO - wsgiref == 0.1.2 07:44:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:44:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:06 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 0x7f524f74cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf2a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb9410>, '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 0xfba310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfba7a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1464008973.203001-1874161468', '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 07:44:06 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 07:44:06 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 07:44:06 INFO - Using env: {'DISPLAY': ':0', 07:44:06 INFO - 'HOME': '/home/cltbld', 07:44:06 INFO - 'LANG': 'en_US.UTF-8', 07:44:06 INFO - 'LANGUAGE': 'en_US:en', 07:44:06 INFO - 'LOGNAME': 'cltbld', 07:44:06 INFO - 'MAIL': '/var/mail/cltbld', 07:44:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:06 INFO - 'MOZ_NO_REMOTE': '1', 07:44:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:06 INFO - 'NO_EM_RESTART': '1', 07:44:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:06 INFO - 'PWD': '/builds/slave/test', 07:44:06 INFO - 'SHELL': '/bin/bash', 07:44:06 INFO - 'SHLVL': '1', 07:44:06 INFO - 'TERM': 'linux', 07:44:06 INFO - 'TMOUT': '86400', 07:44:06 INFO - 'USER': 'cltbld', 07:44:06 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1464008973.203001-1874161468', 07:44:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:06 INFO - '_': '/tools/buildbot/bin/python'} 07:44:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:06 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)) 07:44:06 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)) 07:44:06 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)) 07:44:06 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)) 07:44:06 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)) 07:44:06 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)) 07:44:06 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)) 07:44:06 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)) 07:44:06 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)) 07:44:06 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)) 07:44:06 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)) 07:44:06 INFO - Cleaning up... 07:44:06 INFO - Return code: 0 07:44:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:44:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f524f74cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf2a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb9410>, '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 0xfba310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfba7a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1464008973.203001-1874161468', '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 07:44:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:44:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:44:06 INFO - Using env: {'DISPLAY': ':0', 07:44:06 INFO - 'HOME': '/home/cltbld', 07:44:06 INFO - 'LANG': 'en_US.UTF-8', 07:44:06 INFO - 'LANGUAGE': 'en_US:en', 07:44:06 INFO - 'LOGNAME': 'cltbld', 07:44:06 INFO - 'MAIL': '/var/mail/cltbld', 07:44:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:06 INFO - 'MOZ_NO_REMOTE': '1', 07:44:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:06 INFO - 'NO_EM_RESTART': '1', 07:44:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:06 INFO - 'PWD': '/builds/slave/test', 07:44:06 INFO - 'SHELL': '/bin/bash', 07:44:06 INFO - 'SHLVL': '1', 07:44:06 INFO - 'TERM': 'linux', 07:44:06 INFO - 'TMOUT': '86400', 07:44:06 INFO - 'USER': 'cltbld', 07:44:06 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1464008973.203001-1874161468', 07:44:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:06 INFO - '_': '/tools/buildbot/bin/python'} 07:44:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:06 INFO - Downloading/unpacking jsonschema 07:44:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:44:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:44:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:44:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:44:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:44:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:44:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:44:08 INFO - Downloading/unpacking functools32 (from jsonschema) 07:44:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:44:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:44:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:44:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:44:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:44:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:44:08 INFO - Downloading functools32-3.2.3-2.tar.gz 07:44:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:44:08 INFO - warning: no files found matching '*.txt' 07:44:08 INFO - no previously-included directories found matching 'build' 07:44:08 INFO - no previously-included directories found matching 'dist' 07:44:08 INFO - no previously-included directories found matching '.git*' 07:44:08 INFO - Installing collected packages: jsonschema, functools32 07:44:08 INFO - Running setup.py install for functools32 07:44:08 INFO - warning: no files found matching '*.txt' 07:44:08 INFO - no previously-included directories found matching 'build' 07:44:08 INFO - no previously-included directories found matching 'dist' 07:44:08 INFO - no previously-included directories found matching '.git*' 07:44:08 INFO - Successfully installed jsonschema functools32 07:44:08 INFO - Cleaning up... 07:44:08 INFO - Return code: 0 07:44:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:44:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f524f74cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf2a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb9410>, '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 0xfba310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfba7a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1464008973.203001-1874161468', '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 07:44:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 07:44:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:44:08 INFO - Using env: {'DISPLAY': ':0', 07:44:08 INFO - 'HOME': '/home/cltbld', 07:44:08 INFO - 'LANG': 'en_US.UTF-8', 07:44:08 INFO - 'LANGUAGE': 'en_US:en', 07:44:08 INFO - 'LOGNAME': 'cltbld', 07:44:08 INFO - 'MAIL': '/var/mail/cltbld', 07:44:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:08 INFO - 'MOZ_NO_REMOTE': '1', 07:44:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:08 INFO - 'NO_EM_RESTART': '1', 07:44:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:08 INFO - 'PWD': '/builds/slave/test', 07:44:08 INFO - 'SHELL': '/bin/bash', 07:44:08 INFO - 'SHLVL': '1', 07:44:08 INFO - 'TERM': 'linux', 07:44:08 INFO - 'TMOUT': '86400', 07:44:08 INFO - 'USER': 'cltbld', 07:44:08 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1464008973.203001-1874161468', 07:44:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:08 INFO - '_': '/tools/buildbot/bin/python'} 07:44:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:09 INFO - Downloading/unpacking flake8 07:44:09 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 07:44:09 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 07:44:09 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 07:44:09 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 07:44:09 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 07:44:09 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 07:44:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:44:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:44:11 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 07:44:11 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 07:44:11 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 07:44:11 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 07:44:11 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 07:44:11 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 07:44:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:44:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:44:11 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 07:44:11 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 07:44:11 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 07:44:11 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 07:44:11 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 07:44:11 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 07:44:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:44:11 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 07:44:11 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 07:44:11 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 07:44:11 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 07:44:11 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 07:44:11 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 07:44:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:44:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:44:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:44:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:44:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:44:11 INFO - no previously-included directories found matching 'docs/_build' 07:44:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:44:11 INFO - Running setup.py install for pep8 07:44:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:44:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:44:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:44:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:44:11 INFO - no previously-included directories found matching 'docs/_build' 07:44:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:44:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:44:11 INFO - Cleaning up... 07:44:11 INFO - Return code: 0 07:44:11 INFO - Running post-action listener: _resource_record_post_action 07:44:11 INFO - Running post-action listener: _start_resource_monitoring 07:44:12 INFO - Starting resource monitoring. 07:44:12 INFO - ##### 07:44:12 INFO - ##### Running install step. 07:44:12 INFO - ##### 07:44:12 INFO - Running pre-action listener: _resource_record_pre_action 07:44:12 INFO - Running main action method: install 07:44:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:44:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:44:12 INFO - Reading from file tmpfile_stdout 07:44:12 INFO - Detecting whether we're running mozinstall >=1.0... 07:44:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:44:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:44:12 INFO - Reading from file tmpfile_stdout 07:44:12 INFO - Output received: 07:44:12 INFO - Usage: mozinstall [options] installer 07:44:12 INFO - Options: 07:44:12 INFO - -h, --help show this help message and exit 07:44:12 INFO - -d DEST, --destination=DEST 07:44:12 INFO - Directory to install application into. [default: 07:44:12 INFO - "/builds/slave/test"] 07:44:12 INFO - --app=APP Application being installed. [default: firefox] 07:44:12 INFO - mkdir: /builds/slave/test/build/application 07:44:12 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'] 07:44:12 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 07:44:27 INFO - Reading from file tmpfile_stdout 07:44:27 INFO - Output received: 07:44:27 INFO - /builds/slave/test/build/application/firefox/firefox 07:44:27 INFO - Running post-action listener: _resource_record_post_action 07:44:27 INFO - ##### 07:44:27 INFO - ##### Running run-tests step. 07:44:27 INFO - ##### 07:44:27 INFO - Running pre-action listener: _resource_record_pre_action 07:44:27 INFO - Running main action method: run_tests 07:44:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:44:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:44:27 INFO - Python 2.7.3 07:44:27 INFO - Return code: 0 07:44:27 INFO - grabbing minidump binary from tooltool 07:44:27 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')]} 07:44:27 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 0xfb9410>, '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 0xfba310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfba7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:44:27 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 07:44:27 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 07:44:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:44:27 INFO - Return code: 0 07:44:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:44:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:44:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:44:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:44:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:44:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:44:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:44:28 INFO - Return code: 0 07:44:28 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/RGErAEGHSFmeSM9oVvVPCQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 07:44:28 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/RGErAEGHSFmeSM9oVvVPCQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --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 07:44:28 INFO - Using env: {'DISPLAY': ':0', 07:44:28 INFO - 'HOME': '/home/cltbld', 07:44:28 INFO - 'LANG': 'en_US.UTF-8', 07:44:28 INFO - 'LANGUAGE': 'en_US:en', 07:44:28 INFO - 'LOGNAME': 'cltbld', 07:44:28 INFO - 'MAIL': '/var/mail/cltbld', 07:44:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:44:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:44:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:28 INFO - 'MOZ_NO_REMOTE': '1', 07:44:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:44:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:28 INFO - 'NO_EM_RESTART': '1', 07:44:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:28 INFO - 'PWD': '/builds/slave/test', 07:44:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:44:28 INFO - 'SHELL': '/bin/bash', 07:44:28 INFO - 'SHLVL': '1', 07:44:28 INFO - 'TERM': 'linux', 07:44:28 INFO - 'TMOUT': '86400', 07:44:28 INFO - 'USER': 'cltbld', 07:44:28 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1464008973.203001-1874161468', 07:44:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:28 INFO - '_': '/tools/buildbot/bin/python'} 07:44:28 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/RGErAEGHSFmeSM9oVvVPCQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 07:44:29 INFO - mozversion application_buildid: 20160523045840 07:44:29 INFO - mozversion application_changeset: ad804098d30c0b227c73e344c9addd9e5a7c3e09 07:44:29 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:44:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:44:29 INFO - mozversion application_name: Firefox 07:44:29 INFO - mozversion application_remotingname: firefox-dev 07:44:29 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:44:29 INFO - mozversion application_vendor: Mozilla 07:44:29 INFO - mozversion application_version: 48.0a2 07:44:29 INFO - mozversion platform_buildid: 20160523045840 07:44:29 INFO - mozversion platform_changeset: ad804098d30c0b227c73e344c9addd9e5a7c3e09 07:44:29 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:44:29 INFO - mozversion platform_version: 48.0a2 07:44:29 INFO - using testdate: 1464014669 07:44:29 INFO - actual date: 1464014669 07:44:29 INFO - starting webserver on 'localhost:45201' 07:44:29 INFO - SUITE-START | Running 2 tests 07:44:29 INFO - TEST-START | dromaeo_css 07:44:29 INFO - operating with platform_type : linux_ 07:44:29 INFO - Initialising browser for dromaeo_css test... 07:44:29 INFO - TEST-INFO | started process 24643 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzkSBLg/profile http://localhost:45201/getInfo.html) 07:44:33 INFO - PROCESS | 24643 | 07:44:33 INFO - PROCESS | 24643 | (process:24719): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:44:33 INFO - PROCESS | 24643 | __metrics Screen width/height:1600/1200 07:44:33 INFO - PROCESS | 24643 | colorDepth:24 07:44:33 INFO - PROCESS | 24643 | Browser inner width/height: 1024/697 07:44:34 INFO - PROCESS | 24643 | __metrics 07:44:34 ERROR - PROCESS | 24643 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 07:44:35 INFO - TEST-INFO | 24643: exit 0 07:44:35 INFO - Browser initialized. 07:44:35 INFO - Running cycle 1/1 for dromaeo_css test... 07:44:35 INFO - TEST-INFO | started process 24770 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzkSBLg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:44:37 INFO - PROCESS | 24770 | 07:44:37 INFO - PROCESS | 24770 | (process:24839): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:44:47 INFO - PROCESS | 24770 | RSS: Main: 151969792 07:44:47 INFO - PROCESS | 24770 | 07:45:37 INFO - PROCESS | 24770 | 1464014737031 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] 07:47:44 INFO - PROCESS | 24770 | Cycle 1(1): loaded http://localhost:45201/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45201/tests/dromaeo/cssquery-ext.html) 07:47:45 INFO - PROCESS | 24770 | RSS: Main: 155738112 07:47:45 INFO - PROCESS | 24770 | 07:50:47 INFO - PROCESS | 24770 | Cycle 1(1): loaded http://localhost:45201/tests/dromaeo/cssquery-ext.html (next: http://localhost:45201/tests/dromaeo/cssquery-jquery.html) 07:50:48 INFO - PROCESS | 24770 | RSS: Main: 153640960 07:50:48 INFO - PROCESS | 24770 | 07:53:49 INFO - PROCESS | 24770 | Cycle 1(1): loaded http://localhost:45201/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45201/tests/dromaeo/cssquery-mootools.html) 07:53:50 INFO - PROCESS | 24770 | RSS: Main: 153755648 07:53:50 INFO - PROCESS | 24770 | 07:56:52 INFO - PROCESS | 24770 | Cycle 1(1): loaded http://localhost:45201/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45201/tests/dromaeo/cssquery-prototype.html) 07:56:52 INFO - PROCESS | 24770 | RSS: Main: 153718784 07:56:52 INFO - PROCESS | 24770 | 07:59:55 INFO - PROCESS | 24770 | Cycle 1(1): loaded http://localhost:45201/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45201/tests/dromaeo/cssquery-yui.html) 07:59:55 INFO - PROCESS | 24770 | RSS: Main: 154411008 07:59:55 INFO - PROCESS | 24770 | 08:02:57 INFO - PROCESS | 24770 | Cycle 1(1): loaded http://localhost:45201/tests/dromaeo/cssquery-yui.html (next: http://localhost:45201/tests/dromaeo/cssquery-dojo.html) 08:02:58 INFO - PROCESS | 24770 | RSS: Main: 156233728 08:02:58 INFO - PROCESS | 24770 | 08:02:58 INFO - PROCESS | 24770 | __start_tp_report 08:02:58 INFO - PROCESS | 24770 | _x_x_mozilla_page_load 08:02:58 INFO - PROCESS | 24770 | _x_x_mozilla_page_load_details 08:02:58 INFO - PROCESS | 24770 | |i|pagename|runs| 08:02:58 INFO - PROCESS | 24770 | |0;dojo.html;3294.2752594429226;3356.7985920844735;3378.375000624885;3398.0825177202155;3398.9320213595715;5655.4061823508555;5664.235328230688;5685.715714214293;5728.140778883169;5732.369439361677;5641.323041235048;5704.1443783432505;5738.081906894898;5744.138379243115;5753.165790960319;5147.356580427447;5196.714180720059;5237.47625237477;5270.578353731711;5313.867153321159;5053.620978426614;5167.612429067816;5313.867153321159;5342.465753424646;5348.358197016363;5058.671186372892;5115.309433226504;5122.282880396748;5124.92312615311;5255.106631872572;5105.744712764384;5110.923336149961;5124.590032797404;5129.384473863123;5141.280220769114;4958.752062396866;5041.6722913010535;5050.217216331438;5052.949470505285;5088.084144853925;5526.336839579236;5537.750801213955;5545.279113715232;5560.360558535739;5569.805056822992;6083.087536869461;6097.298810636789;6099.847503812396;6104.664243466652;6111.327753947062;5823.650580965155;6059.909101363483;6133.601315914496;6138.232720909887;6141.825783693951;5618.85952851182;5621.437856214387;5621.550275977912;5628.043232650419;5667.574931880125;6067.453929146398;6084.5132389408745;6114.6636934969;6123.2652081750475;6127.938720612826;5904.763809447574;5918.526517878559;5947.732352044169;5955.52355811534;5986.910196347058;6044.395560443921;6046.881326954527;6049.78825741097;6053.334133245339;6069.544784141119;5911.76352945886;6015.518758499397;6032.607880487754;6065.090236464477;6115.240341084353;5827.096799996008;5891.734871930774;5892.646441213541;5896.056630939029;5944.197533333031;4474.686771925999;4490.528494508029;4493.4607847057905;4505.639548836085;4515.571020753023;4051.554329023805;4054.351303791379;4100.487439070116;4105.958940410617;4138.420621113047;5638.802641907513;5778.306603207558;5814.389489103668;5886.499647529922;5894.351621321651;5948.10778383246;5970.34326224115;5974.880502389928;5978.04351303798;5980.43185897339;5704.515116215085;5772;5866.50134738552;5885.705714714247;5911.083782013795;5198.870028249324;5199.662021968636;5204.0372531081875;5207.270982062514;5229.294045303911;6137.468918203611;6337.271213810379;6346.650934198571;6350.968245158837;6368.490520758328;6058.394160583906;6129.632222066691;6143.139960405636;6154.415330543591;6161.568690191643;6111.052786818051;6129.816105516842;6130.049842274455;6141.07883817431;6155.538334624832;5778.306603207642;5809.24479817621;5823.213866128188;5829.358770535153;5845.152452894392;5971.552133589911;6005.789797357072;6012.6993650316435;6013.7293821779;6036.456718895321;5830.76676932918;5863.530917526502;5867.002609556301;5881.05903055509;5882.294124705063;5764.221830052889;5821.883562328814;5848.561357898089;5954.583179177416;6010.87978240424;5845.736941837543;5873.471387575139;5873.970630146822;5880;5881.05903055509;5991.071383935497;5994.820155395345;6003.159557661844;6004.099385092097;6050.848728781815;5606.495415412633;5783.248177737036;5819.185314056121;5850.6782126981725;5865.472107510344 08:02:58 INFO - PROCESS | 24770 | |1;ext.html;611.5260672978444;669.1100835888268;675.9628220447875;686.3102581905184;706.3184027413545;36927.446088308665;37567.624323756754;37827;37934.62065379352;37947.43078853819;38666;39126.41310380347;39274.21451570967;39298.60701392985;39398.40902386467;8561.443506172094;8725.214730674237;8743.912560874374;8762.780930476725;8777.95611021944;8636.481811091324;8980.236679882219;9025.909740902573;9037.41256818308;9043.954780226122;9025.95487022564;9095.818083638324;9099.181073703365;9099.272058235325;9107.863382049274;8981.416207946462;8989.235914947238;9014.549272536347;9050.818983620324;9063.365564410495;8931.97282312536;8977.551122443852;8978.191962723386;9035.683751068682;9049.2308153807;33502;39790.20419591621;40666.39000414996;40688.186236275404;40848.79575602103;3522.7181825453904;3658.0306218852024;3931.68546516278;4155.563665815076;4337.696361254713;28174.85912570424;28538.71461285381;28776.424471510454;28813;29661.70338296611;4342.435483387171;4374.212641724488;4382.846600368972;4399.296112621997;4464.6428285737065;192604;193441;193786;193984;196802;37087.07282317964;37308;39041.80479097643;39517.80241098776;39823.20353592912;37681.81159094187;37762.43356349657;37802.24395512074;37894.62105378966;38005;17556.912215439097;17610.38363657266;17788.733169002477;17845.10774461298;17870.642587148184;14887.925560372345;15017.098974061591;15076.39694412233;15105.093694378373;15123.470678526199;9229.815403692022;9342.392744471588;9344.859827102599;9362.438253704799;9425.481598512148;3501.28223714138;3583.802890841029;3633.7274704396746;3648.288583726148;3648.635136486383;1100.959593184449;1103.7902798468265;1111.366521082991;1117.2681893359863;1128.6896103571419;32400.351992960008;32452.513212301834;32771.67228327734;33814.830925845214;33913.152171195914;1233.0505510756668;1279.5585522994552;1281.7244292477162;1297.1114786371365;1368.2020268550837;16259.51221463358;17056.829431705773;17193;17310.567235819206;17356.698247631477;467062;526905;617410;621438;977574;60344.39655603476;60863.39136608577;60889.69555152285;61202.69398652978;61410;1556.704226197019;1570.8193557740778;1581.7943667323175;1582.9762553561475;1605;30737.231569210948;31338.373232535676;33329.50005749867;33459.33081338311;33833.49249761305;56171.71914140403;56418.7179064102;56682.43317566771;56756.43243567677;56818;440983;444093;445124;445406;445848;47333.52666473429;47480.287795683784;47734;49252.2612160825;49501.257481137094;50196.49803501918;51249.7437512825;51425.48574514207;51523.742381287855;51892;37840.62159378481;38058.23883522259;38109.4283585752;40264.396034058926;42344.5765542353;40973.59026409698;41083.1783364337;41443.37834932418;41533.58466415418;42071;41525.792371037955;41919.580804191566;42551;42778.35832462453;43030.78484607557;34269.314613708084;35589.28821423505;36044.4593331095;36091.458628120075;36412.635873640924;28048.43903121885;28434;28605.713942860304;28722.425551488435;28895.711042890143 08:02:58 INFO - PROCESS | 24770 | |2;jquery.html;401.64053172410684;411.29108553958315;413.9089400331926;425.10727472308156;430.7394026613899;14608.19654918979;19029.52426189346;19663.31178408756;20257.39227823164;20317.984100794958;19621.411357659294;20112;20349.59300813983;20737.274195403163;20917.686234706453;5590.273264475612;5647.604667673265;5856.531477481792;5880.353161152269;5892.734826932777;5673.177389278552;5723.942760572403;5753.597248192628;5766.394528574502;5787.160861675055;5595.49640532352;5656.886862262752;5731.512821410185;5756.568257380693;5838.299404071496;5701.116326969326;5763.567732420085;5765.135229715555;5773.538116950634;5792.594518383715;5057.393112826448;5160.974195129038;5188.299579556749;5210.6613070150315;5243.2659427680155;23312.3006309811;23437;23869.283921482383;23871;23908.163214287415;2517.509085728284;2574.897004119833;2782.596523504101;3096.8916087936814;3221.8389080546112;9569.90430095697;10133.746656333577;12486.375681215994;14471.42114315426;15416.075035497906;1960.5490737130397;1971.2213675598202;2036.2771216218177;2057.4650590846336;2112.5669237806214;66796.66601667009;73114;73964.63017684931;76531;77487.99999999943;10239.18086553074;11020.889791102147;11080.889191108146;11161.888381116247;11223.382713950648;15377.615559611098;15384.30770615325;15488.767668484981;15529;15540.378384864705;8187.75436736887;8251.257386835214;8263.752087437386;8311.33509319265;8341.624626891804;8022.638981245858;8119.675212991532;8157.510549367057;8193.180681931879;8257.669693212325;4743.217369134054;4751.6500866889455;4783.306420568998;4851.660383773102;4865.56209941107;1884.9161732004152;1922.3175772600805;1974.2004488182308;2013.6073465674347;2022.9089690963647;1048.6749107776614;1097.5938902606088;1128.5767837061103;1136.176272202663;1165.5629139072848;16786.32854685799;18692.626147477247;18867.622647547247;19569.804301957083;20955.8952205238;1088.2491081153978;1100.5212732461405;1159.5535718748342;1171.420147027227;1202.5911190195375;11258.268212566158;11275.267107637977;11282.605108821315;11395.974362307266;11429.828552571718;388133;585511;616835;639997;647485;100164;102853.48573257236;103026;104158;104465;1123.2418117770471;1151.8099513580166;1153.5270539078938;1169.8245263210417;1176.0474016046858;18067.51875520976;18109.63780724352;18197.54506137357;18206.271749129886;18365.724514132566;40494;41066;41462.1707565841;42509.57490425056;42753.35869961891;56578.43421565896;61765;62377.68811155915;62525;63412.68293658502;8484.957575212084;8610.526421046903;8686.869696954423;8832.955835220782;8882.733517994471;12869.485220591447;13895.791563126764;14154.646133846736;14311.642208944859;14327.78508322355;12419.068569857478;12487.625371238877;12631.87368126307;12697.619071427873;12855.16441431304;8076.555789431638;8251.502930902552;11818.940905295418;11959.581414650445;12411.131220814455;8296.045954715284;8357.414980951275;8576.485410875368;8676.956615216883;8758.167974042455;12724.109312348046;12905.741885162057;12965.15726477776;13453.46186152543;13607.387667555182;12585.748285034431;12599.559015434415;12599.811002835148;12684.492620295085;12687.302198379179 08:02:58 INFO - PROCESS | 24770 | |3;mootools.html;1541.4681934732519;1557.0657605436736;1745.9476215713532;1896.6301571193624;1896.649119912817;7460.515066520672;8065.637046332914;8217.589120543978;8434.325253979674;8476.618552165144;8101.230383113595;8185.795355116125;8268.29719473844;8293.295069919064;8298.460600060991;2358.6108292131776;2373.845700029501;2386.3914701751114;2387.761223877607;2387.868667223302;2263.739669937962;2288.2220045184636;2305.354500739787;2308.134449581407;2350.4241460842118;2280.612295909691;2301.2866011536476;2311.167979527369;2366.905323787055;2375.1805627058725;2270.375646697155;2280.2019293247395;2293.472501324696;2294.575503531852;2361.350628577155;2314.36355002374;2330.918417855367;2338.356951838241;2343.7070366204225;2344.4256157241584;8443.915560844374;8449.32405407566;8453.196946290092;8512.31901447889;8526.57367131641;5105.617078719111;5144.511271429208;5211.530962213381;5235.450277720823;5250.97374513125;3423.6747508986605;3423.96576034239;3524.242287908112;3574.767640103411;3597.928041439183;1200.7838589053968;1222.1078612612841;1253.3921048291572;2222.3540931074463;2314.143766806276;11345.149113816497;11557.133215008907;11621.825672614917;11622.244554103956;11622.59320923772;4318.481782186095;4329.069250111241;4345.152695224464;4361;4435.889102772392;9397.389169703947;9421.576029078708;9441;9445.763855903657;9451.574679139456;5162.432132465426;5172.27588137661;5181.041507321158;5199.272101905736;5204.037253108111;4360.062586543908;4602.516735742699;4674.95325046752;4691.366665500113;4835.443923948791;3771.113788259757;3813.6567708905777;3900.941485877714;3936.7244292899795;3958.4853968984426;1133.280366966982;1151.8560179977503;1154.9769004619861;1170.1808733886314;1174.7180676637715;1043.5721354244724;1087.923845330835;1103.365564800227;1111.699841042914;1113.966581002555;5865.560082993792;6115.082737589397;6150.3849615039035;6183.752649894044;6265;987.3335498538457;1051.8106740786732;1055.5302890213782;1064.0370464729433;1073.9463026848625;4094.9385759213637;4161.396597493346;4183.205191013698;4193.391958166048;4250.574942505787;10209.591616335412;10443.68668939933;10601.522931468102;10614.946925265478;10632.25574209798;10072.798544029078;10337.534810933526;10416.635417760343;10460.058594726359;10471.952804719467;8038.919610803817;8070.677172913018;8202.835943281101;8231.42380033392;8263.256306932284;5880.206172166702;5936.703164841654;5982.252218472691;5984.115003773797;5999.370066143167;8774.38579299443;8867.379283450096;8951.283897288331;8979.14698103679;8998.775030624287;8914.28685705155;8976.326775491734;9054.547272636473;9113.954430227806;9160.908390916005;6797.89803152963;7340.376068034277;7425.480216384801;7558.093028836574;7582.582957937367;8052.355811535181;8062.395320351115;8084.353251739729;8115.229053239933;8132.024157100949;7024.578525288499;7226.313500217471;7255.09311336083;7314;7359.411247100326;7093.858122837411;7131.393831524171;7342.339189472973;7380.335769780745;7394.704211831467;6818.693158807766;6828.248892621907;6829.975503674488;6850.691718872762;6859.897101543381;5231.738413079254;5270.104082306094;5364.6512976656395;5456.072467680583;5562.638428502134;5068.087744206078;5140.717260550706;5228.37259528859;5264.894702106013;5315.3090098286975 08:02:58 INFO - PROCESS | 24770 | |4;prototype.html;342.602581006033;343.3013816882644;344.28217167206367;346.0431905780519;351.978881267124;6540.117084193633;6582.144321238238;6592.604443733373;6648.06927030215;6683.832904177398;6583.967080164604;6639.435647969928;6656.334366563341;6661.933380666192;6684.264730879611;4698.036902435001;4763.356946812188;4947.653664243504;4960.404751429834;4960.759810047488;4929.926051109236;4946.653734238605;4947.03532811102;4952.455229924705;4958.6281028922795;4909.5581397674205;4917.606591472691;4929.4824043475455;4929.704217746947;4929.950700492985;4911.75441227939;4918.631102667278;4922.606191504671;4934.185859333224;4946.208606622923;4274.358846173099;4275.893102672427;4284.571542845691;4285.014446677282;4289.442372491588;6162.291336496315;6299.149614802035;6347.428731414148;6356;6367.904481432783;5728.112142617901;5780.971095144498;5787.3923238059815;5792.189093526909;5799.594028418012;6925.342092501204;6932.133483314586;6935.6878940447805;6940.514164008521;6959.61722105284;4740.3837501124635;4766.38037055184;4776.522347765231;4778.474367819537;4779.139754844126;7245.347918687344;7277.199508054163;7284.380827629658;7296.890546641805;7304.393033532614;4781.760911954389;4852.56326930578;4853.12643724126;4867.683600565952;4878.682885612424;4906.1414252505665;4925.433575138905;4927.630427717864;4933.186024306021;4938.160512712848;5657.830265092054;5731.971340143273;5743.310802703702;5747.080467125324;5768.855778605484;7038.436925045984;7045.401140903081;7050.717971281091;7053.329933656294;7055.858882822417;1732.41098026669;1747.3098126240063;1747.7028905086165;1756.1570446185901;1757.1038770227021;1102.404701461202;1128.1313388690662;1134.8184290513477;1166.445938179358;1169.5438778876246;6781.796546103625;6848.178218613798;6864.1762988440705;6876.896846547305;6883.483738719616;6984.196817365966;7237.565746055148;7245.239249878687;7278.963605182046;7287.781366558906;6673.833154171185;6869.622170780655;6874.003269525891;6885.586864788129;6893.517453778288;3932.311845427039;3938.4092386142306;3957.08986933007;3957.762534247954;3971.2057588481844;7626.313631773167;7627.8855817162785;7660.042494688164;7668.041494813148;7672.427152433737;7340.4127669786285;7539.962300188464;7541.057367829021;7543.396528277724;7561.621918904033;7608.961955190189;7667.424943129287;7667.8849817252785;7667.923320766721;7669.7315593953945;7252.492325537161;7289.854202916018;7307.26927307265;7309.963450182715;7316.524425912298;7196.460265480006;7204.171520275236;7237.927620723725;7241.167265764505;7246.963765181351;7338.11942566874;7587.203343648837;7590.1650818411035;7635.312821846061;7641.235876412315;4866.926996095132;4925.310456536159;4946.985867897;4986.850394488171;5003.224500202475;7273.127224732854;7305.41556675454;7312.597807120659;7316.451266154953;7321.597312147883;7034.261402552863;7068.787936361918;7096.858062838611;7107.609081500567;7136.107986501687;6891.724331026903;7008.894866576903;7011.3339232772805;7062.823429414306;7090;6930.168379794457;6940.583564986117;6941.826454338682;6963.1644202696;6981.3367730065565;7107.715691372287;7108.289171082851;7113.146422429341;7188.4968052235845;7216.278372162742;6875.89686154698;6905.136857892763;6915.273896240822;6920.515563910478;6929.688164032731 08:02:58 INFO - PROCESS | 24770 | |5;yui.html;824.7072289337285;856.6616186606294;873.8558137907246;878.8725634782957;907.1291560102302;14547.78178327326;14607.196604186793;14711.117332960002;14716.117032978029;14848.1091134532;13697.58907232782;13970.37133329;14046.29768511573;14063.578092657237;14065.507707230248;763.3053920931953;891.5854127830557;916.2212119698237;917.6329468212735;919.783850795066;903.0653273861554;913.5934509143434;921.0559176843756;922.8615707643874;923.1276443760648;960.3805545423198;961.0149596663406;970.7864269860655;973.1193270090579;973.3916302311055;955.4506158958627;962.0091305954878;962.7015625156224;963.1091240602415;963.4075043848053;696.6969368324795;697.9860402791916;701.113091938698;704.9612271325075;707.4552594502204;15004;15119.546413607499;15122.848771512254;15177.392904283815;15222.543323700307;14268.286585670676;14558.92720536401;14644.267786610733;14694.191819449927;14765.852341476555;11545.763389288535;11601;11686.532538698442;11772.88227117735;11798.941005294919;4033.737807042533;4038.899027524306;4146.274401979642;4206.095689426788;4206.348016057516;55740;55998;56055.71972140154;56195.71902140504;57877;11467.369294688706;11546.712511333324;11551.595694150665;11715.472803723853;11775.05799536035;20121.49696257576;20298.18807247723;20460;21063.26278580273;21268;8631.913680863237;8678.262347700389;8767.298616110696;8780.956095219482;8902.777430564158;4790.784414701347;4825.879353016133;4882.267659851051;4915.287283343895;4977.104121258209;3259.4133056050136;3337.1823903143886;3347.782394144373;3348.0290715692663;3356.848941797625;621.5052798020768;627.6108812536256;638.2468686949444;640.702073535808;642.5084810120262;799.6081919859344;802.9116797152309;803.9276465118168;830.9958450207711;837.8282452097305;9168.862467062865;9430.575624096795;9519.23846092311;9521.904780952102;9662.08210220028;678.7285085965653;788.129601336949;799.0690845165434;814.3810703865105;849.9277561407226;4505.864824055284;4524.751138687404;4554.0664163847;4580.335851301609;4611.515790841913;59801.40198597958;60421;60944.08583871245;61244.38755612476;61439;54793;55563;56351;56586.15120773192;56978.43021569814;50783.74608126936;50884;51715.74142129265;51986.740066299426;52218.47781522136;8540.27407670355;8895.955520222358;9023.458592484472;9081.77295567616;9085;39029.609703903734;40066.797996060166;40108.59891401049;40977;41168;46400;47238.76380618075;49702;50543;50595;10974.231803773979;11206.215564910379;11310.208285419942;11313.943430282796;11618.186726929034;12479.251244925334;12479.376031198586;12542.372881356077;12588.244705317711;12631.81052284198;11015.449227538431;11092.223544351818;11590.42047897585;11641.359725214856;12179.512819487121;11656.825147622962;11709.531618735497;11811.232269902428;11915;12011.219270747373;13463.394147263201;13640;13906.721865562835;14209.573712788218;14273.000889937604;10054;10514.94742526313;10615.416152111398;10688.89311106879;10776.030157285883;9457.38526995743;9717.611295548098;9779.943804858754;9854.310198286052;9892.258080644124 08:02:58 INFO - PROCESS | 24770 | __end_tp_report 08:02:58 INFO - PROCESS | 24770 | __start_cc_report 08:02:58 INFO - PROCESS | 24770 | _x_x_mozilla_cycle_collect,327 08:02:58 INFO - PROCESS | 24770 | __end_cc_report 08:02:58 INFO - PROCESS | 24770 | __startTimestamp1464015778109__endTimestamp 08:02:58 INFO - PROCESS | 24770 | 08:02:58 INFO - PROCESS | 24770 | ------- Summary: start ------- 08:02:58 INFO - PROCESS | 24770 | Number of tests: 6 08:02:58 INFO - PROCESS | 24770 | 08:02:58 INFO - PROCESS | 24770 | [#0] dojo.html Cycles:165 Average:5609.25 Median:5845.15 stddev:630.06 (10.8%) stddev-sans-first:605.25 08:02:58 INFO - PROCESS | 24770 | Values: 3294.3 3356.8 3378.4 3398.1 3398.9 5655.4 5664.2 5685.7 5728.1 5732.4 5641.3 5704.1 5738.1 5744.1 5753.2 5147.4 5196.7 5237.5 5270.6 5313.9 5053.6 5167.6 5313.9 5342.5 5348.4 5058.7 5115.3 5122.3 5124.9 5255.1 5105.7 5110.9 5124.6 5129.4 5141.3 4958.8 5041.7 5050.2 5052.9 5088.1 5526.3 5537.8 5545.3 5560.4 5569.8 6083.1 6097.3 6099.8 6104.7 6111.3 5823.7 6059.9 6133.6 6138.2 6141.8 5618.9 5621.4 5621.6 5628.0 5667.6 6067.5 6084.5 6114.7 6123.3 6127.9 5904.8 5918.5 5947.7 5955.5 5986.9 6044.4 6046.9 6049.8 6053.3 6069.5 5911.8 6015.5 6032.6 6065.1 6115.2 5827.1 5891.7 5892.6 5896.1 5944.2 4474.7 4490.5 4493.5 4505.6 4515.6 4051.6 4054.4 4100.5 4106.0 4138.4 5638.8 5778.3 5814.4 5886.5 5894.4 5948.1 5970.3 5974.9 5978.0 5980.4 5704.5 5772.0 5866.5 5885.7 5911.1 5198.9 5199.7 5204.0 5207.3 5229.3 6137.5 6337.3 6346.7 6351.0 6368.5 6058.4 6129.6 6143.1 6154.4 6161.6 6111.1 6129.8 6130.0 6141.1 6155.5 5778.3 5809.2 5823.2 5829.4 5845.2 5971.6 6005.8 6012.7 6013.7 6036.5 5830.8 5863.5 5867.0 5881.1 5882.3 5764.2 5821.9 5848.6 5954.6 6010.9 5845.7 5873.5 5874.0 5880.0 5881.1 5991.1 5994.8 6003.2 6004.1 6050.8 5606.5 5783.2 5819.2 5850.7 5865.5 08:02:58 INFO - PROCESS | 24770 | 08:02:58 INFO - PROCESS | 24770 | [#1] ext.html Cycles:180 Average:58111.45 Median:39654.00 stddev:128164.65 (323.2%) stddev-sans-first:128451.48 08:02:58 INFO - PROCESS | 24770 | Values: 611.5 669.1 676.0 686.3 706.3 36927.4 37567.6 37827.0 37934.6 37947.4 38666.0 39126.4 39274.2 39298.6 39398.4 8561.4 8725.2 8743.9 8762.8 8778.0 8636.5 8980.2 9025.9 9037.4 9044.0 9026.0 9095.8 9099.2 9099.3 9107.9 8981.4 8989.2 9014.5 9050.8 9063.4 8932.0 8977.6 8978.2 9035.7 9049.2 33502.0 39790.2 40666.4 40688.2 40848.8 3522.7 3658.0 3931.7 4155.6 4337.7 28174.9 28538.7 28776.4 28813.0 29661.7 4342.4 4374.2 4382.8 4399.3 4464.6 192604.0 193441.0 193786.0 193984.0 196802.0 37087.1 37308.0 39041.8 39517.8 39823.2 37681.8 37762.4 37802.2 37894.6 38005.0 17556.9 17610.4 17788.7 17845.1 17870.6 14887.9 15017.1 15076.4 15105.1 15123.5 9229.8 9342.4 9344.9 9362.4 9425.5 3501.3 3583.8 3633.7 3648.3 3648.6 1101.0 1103.8 1111.4 1117.3 1128.7 32400.4 32452.5 32771.7 33814.8 33913.2 1233.1 1279.6 1281.7 1297.1 1368.2 16259.5 17056.8 17193.0 17310.6 17356.7 467062.0 526905.0 617410.0 621438.0 977574.0 60344.4 60863.4 60889.7 61202.7 61410.0 1556.7 1570.8 1581.8 1583.0 1605.0 30737.2 31338.4 33329.5 33459.3 33833.5 56171.7 56418.7 56682.4 56756.4 56818.0 440983.0 444093.0 445124.0 445406.0 445848.0 47333.5 47480.3 47734.0 49252.3 49501.3 50196.5 51249.7 51425.5 51523.7 51892.0 37840.6 38058.2 38109.4 40264.4 42344.6 40973.6 41083.2 41443.4 41533.6 42071.0 41525.8 41919.6 42551.0 42778.4 43030.8 34269.3 35589.3 36044.5 36091.5 36412.6 28048.4 28434.0 28605.7 28722.4 28895.7 08:02:58 INFO - PROCESS | 24770 | 08:02:58 INFO - PROCESS | 24770 | [#2] jquery.html Cycles:180 Average:31813.45 Median:11534.23 stddev:95952.69 (831.9%) stddev-sans-first:96192.88 08:02:58 INFO - PROCESS | 24770 | Values: 401.6 411.3 413.9 425.1 430.7 14608.2 19029.5 19663.3 20257.4 20318.0 19621.4 20112.0 20349.6 20737.3 20917.7 5590.3 5647.6 5856.5 5880.4 5892.7 5673.2 5723.9 5753.6 5766.4 5787.2 5595.5 5656.9 5731.5 5756.6 5838.3 5701.1 5763.6 5765.1 5773.5 5792.6 5057.4 5161.0 5188.3 5210.7 5243.3 23312.3 23437.0 23869.3 23871.0 23908.2 2517.5 2574.9 2782.6 3096.9 3221.8 9569.9 10133.7 12486.4 14471.4 15416.1 1960.5 1971.2 2036.3 2057.5 2112.6 66796.7 73114.0 73964.6 76531.0 77488.0 10239.2 11020.9 11080.9 11161.9 11223.4 15377.6 15384.3 15488.8 15529.0 15540.4 8187.8 8251.3 8263.8 8311.3 8341.6 8022.6 8119.7 8157.5 8193.2 8257.7 4743.2 4751.7 4783.3 4851.7 4865.6 1884.9 1922.3 1974.2 2013.6 2022.9 1048.7 1097.6 1128.6 1136.2 1165.6 16786.3 18692.6 18867.6 19569.8 20955.9 1088.2 1100.5 1159.6 1171.4 1202.6 11258.3 11275.3 11282.6 11396.0 11429.8 388133.0 585511.0 616835.0 639997.0 647485.0 100164.0 102853.5 103026.0 104158.0 104465.0 1123.2 1151.8 1153.5 1169.8 1176.0 18067.5 18109.6 18197.5 18206.3 18365.7 40494.0 41066.0 41462.2 42509.6 42753.4 56578.4 61765.0 62377.7 62525.0 63412.7 8485.0 8610.5 8686.9 8833.0 8882.7 12869.5 13895.8 14154.6 14311.6 14327.8 12419.1 12487.6 12631.9 12697.6 12855.2 8076.6 8251.5 11818.9 11959.6 12411.1 8296.0 8357.4 8576.5 8677.0 8758.2 12724.1 12905.7 12965.2 13453.5 13607.4 12585.7 12599.6 12599.8 12684.5 12687.3 08:02:58 INFO - PROCESS | 24770 | 08:02:58 INFO - PROCESS | 24770 | [#3] mootools.html Cycles:180 Average:5595.97 Median:5123.17 stddev:3000.97 (58.6%) stddev-sans-first:2993.92 08:02:58 INFO - PROCESS | 24770 | Values: 1541.5 1557.1 1745.9 1896.6 1896.6 7460.5 8065.6 8217.6 8434.3 8476.6 8101.2 8185.8 8268.3 8293.3 8298.5 2358.6 2373.8 2386.4 2387.8 2387.9 2263.7 2288.2 2305.4 2308.1 2350.4 2280.6 2301.3 2311.2 2366.9 2375.2 2270.4 2280.2 2293.5 2294.6 2361.4 2314.4 2330.9 2338.4 2343.7 2344.4 8443.9 8449.3 8453.2 8512.3 8526.6 5105.6 5144.5 5211.5 5235.5 5251.0 3423.7 3424.0 3524.2 3574.8 3597.9 1200.8 1222.1 1253.4 2222.4 2314.1 11345.1 11557.1 11621.8 11622.2 11622.6 4318.5 4329.1 4345.2 4361.0 4435.9 9397.4 9421.6 9441.0 9445.8 9451.6 5162.4 5172.3 5181.0 5199.3 5204.0 4360.1 4602.5 4675.0 4691.4 4835.4 3771.1 3813.7 3900.9 3936.7 3958.5 1133.3 1151.9 1155.0 1170.2 1174.7 1043.6 1087.9 1103.4 1111.7 1114.0 5865.6 6115.1 6150.4 6183.8 6265.0 987.3 1051.8 1055.5 1064.0 1073.9 4094.9 4161.4 4183.2 4193.4 4250.6 10209.6 10443.7 10601.5 10614.9 10632.3 10072.8 10337.5 10416.6 10460.1 10472.0 8038.9 8070.7 8202.8 8231.4 8263.3 5880.2 5936.7 5982.3 5984.1 5999.4 8774.4 8867.4 8951.3 8979.1 8998.8 8914.3 8976.3 9054.5 9114.0 9160.9 6797.9 7340.4 7425.5 7558.1 7582.6 8052.4 8062.4 8084.4 8115.2 8132.0 7024.6 7226.3 7255.1 7314.0 7359.4 7093.9 7131.4 7342.3 7380.3 7394.7 6818.7 6828.2 6830.0 6850.7 6859.9 5231.7 5270.1 5364.7 5456.1 5562.6 5068.1 5140.7 5228.4 5264.9 5315.3 08:02:58 INFO - PROCESS | 24770 | 08:02:58 INFO - PROCESS | 24770 | [#4] prototype.html Cycles:180 Average:5865.51 Median:6733.03 stddev:1814.61 (27.0%) stddev-sans-first:1771.72 08:02:58 INFO - PROCESS | 24770 | Values: 342.6 343.3 344.3 346.0 352.0 6540.1 6582.1 6592.6 6648.1 6683.8 6584.0 6639.4 6656.3 6661.9 6684.3 4698.0 4763.4 4947.7 4960.4 4960.8 4929.9 4946.7 4947.0 4952.5 4958.6 4909.6 4917.6 4929.5 4929.7 4930.0 4911.8 4918.6 4922.6 4934.2 4946.2 4274.4 4275.9 4284.6 4285.0 4289.4 6162.3 6299.1 6347.4 6356.0 6367.9 5728.1 5781.0 5787.4 5792.2 5799.6 6925.3 6932.1 6935.7 6940.5 6959.6 4740.4 4766.4 4776.5 4778.5 4779.1 7245.3 7277.2 7284.4 7296.9 7304.4 4781.8 4852.6 4853.1 4867.7 4878.7 4906.1 4925.4 4927.6 4933.2 4938.2 5657.8 5732.0 5743.3 5747.1 5768.9 7038.4 7045.4 7050.7 7053.3 7055.9 1732.4 1747.3 1747.7 1756.2 1757.1 1102.4 1128.1 1134.8 1166.4 1169.5 6781.8 6848.2 6864.2 6876.9 6883.5 6984.2 7237.6 7245.2 7279.0 7287.8 6673.8 6869.6 6874.0 6885.6 6893.5 3932.3 3938.4 3957.1 3957.8 3971.2 7626.3 7627.9 7660.0 7668.0 7672.4 7340.4 7540.0 7541.1 7543.4 7561.6 7609.0 7667.4 7667.9 7667.9 7669.7 7252.5 7289.9 7307.3 7310.0 7316.5 7196.5 7204.2 7237.9 7241.2 7247.0 7338.1 7587.2 7590.2 7635.3 7641.2 4866.9 4925.3 4947.0 4986.9 5003.2 7273.1 7305.4 7312.6 7316.5 7321.6 7034.3 7068.8 7096.9 7107.6 7136.1 6891.7 7008.9 7011.3 7062.8 7090.0 6930.2 6940.6 6941.8 6963.2 6981.3 7107.7 7108.3 7113.1 7188.5 7216.3 6875.9 6905.1 6915.3 6920.5 6929.7 08:02:58 INFO - PROCESS | 24770 | 08:02:58 INFO - PROCESS | 24770 | [#5] yui.html Cycles:180 Average:15251.90 Median:27308.64 stddev:17641.62 (64.6%) stddev-sans-first:17657.84 08:02:58 INFO - PROCESS | 24770 | Values: 824.7 856.7 873.9 878.9 907.1 14547.8 14607.2 14711.1 14716.1 14848.1 13697.6 13970.4 14046.3 14063.6 14065.5 763.3 891.6 916.2 917.6 919.8 903.1 913.6 921.1 922.9 923.1 960.4 961.0 970.8 973.1 973.4 955.5 962.0 962.7 963.1 963.4 696.7 698.0 701.1 705.0 707.5 15004.0 15119.5 15122.8 15177.4 15222.5 14268.3 14558.9 14644.3 14694.2 14765.9 11545.8 11601.0 11686.5 11772.9 11798.9 4033.7 4038.9 4146.3 4206.1 4206.3 55740.0 55998.0 56055.7 56195.7 57877.0 11467.4 11546.7 11551.6 11715.5 11775.1 20121.5 20298.2 20460.0 21063.3 21268.0 8631.9 8678.3 8767.3 8781.0 8902.8 4790.8 4825.9 4882.3 4915.3 4977.1 3259.4 3337.2 3347.8 3348.0 3356.8 621.5 627.6 638.2 640.7 642.5 799.6 802.9 803.9 831.0 837.8 9168.9 9430.6 9519.2 9521.9 9662.1 678.7 788.1 799.1 814.4 849.9 4505.9 4524.8 4554.1 4580.3 4611.5 59801.4 60421.0 60944.1 61244.4 61439.0 54793.0 55563.0 56351.0 56586.2 56978.4 50783.7 50884.0 51715.7 51986.7 52218.5 8540.3 8896.0 9023.5 9081.8 9085.0 39029.6 40066.8 40108.6 40977.0 41168.0 46400.0 47238.8 49702.0 50543.0 50595.0 10974.2 11206.2 11310.2 11313.9 11618.2 12479.3 12479.4 12542.4 12588.2 12631.8 11015.4 11092.2 11590.4 11641.4 12179.5 11656.8 11709.5 11811.2 11915.0 12011.2 13463.4 13640.0 13906.7 14209.6 14273.0 10054.0 10514.9 10615.4 10688.9 10776.0 9457.4 9717.6 9779.9 9854.3 9892.3 08:02:58 INFO - PROCESS | 24770 | -------- Summary: end -------- 08:02:58 INFO - PROCESS | 24770 | 08:02:58 INFO - TEST-INFO | 24770: exit 0 08:02:58 INFO - TEST-OK | dromaeo_css | took 1109684ms 08:02:58 INFO - TEST-START | kraken 08:02:58 INFO - operating with platform_type : linux_ 08:02:58 INFO - Initialising browser for kraken test... 08:02:58 INFO - TEST-INFO | started process 25014 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFNpnya/profile http://localhost:45201/getInfo.html) 08:03:02 INFO - PROCESS | 25014 | 08:03:02 INFO - PROCESS | 25014 | (process:25090): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:03:03 INFO - PROCESS | 25014 | __metrics Screen width/height:1600/1200 08:03:03 INFO - PROCESS | 25014 | colorDepth:24 08:03:03 INFO - PROCESS | 25014 | Browser inner width/height: 1024/697 08:03:03 INFO - PROCESS | 25014 | __metrics 08:03:03 ERROR - PROCESS | 25014 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 08:03:04 INFO - TEST-INFO | 25014: exit 0 08:03:04 INFO - Browser initialized. 08:03:04 INFO - Running cycle 1/1 for kraken test... 08:03:04 INFO - TEST-INFO | started process 25141 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFNpnya/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:03:06 INFO - PROCESS | 25141 | 08:03:06 INFO - PROCESS | 25141 | (process:25212): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:03:16 INFO - PROCESS | 25141 | RSS: Main: 151879680 08:03:16 INFO - PROCESS | 25141 | 08:03:19 INFO - PROCESS | 25141 | Cycle 1(1): loaded http://localhost:45201/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45201/tests/kraken/driver.html?testName=audio-beat-detection) 08:03:19 INFO - PROCESS | 25141 | RSS: Main: 156647424 08:03:19 INFO - PROCESS | 25141 | 08:03:22 INFO - PROCESS | 25141 | Cycle 1(1): loaded http://localhost:45201/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45201/tests/kraken/driver.html?testName=audio-dft) 08:03:23 INFO - PROCESS | 25141 | RSS: Main: 156733440 08:03:23 INFO - PROCESS | 25141 | 08:03:26 INFO - PROCESS | 25141 | Cycle 1(1): loaded http://localhost:45201/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45201/tests/kraken/driver.html?testName=audio-fft) 08:03:26 INFO - PROCESS | 25141 | RSS: Main: 157007872 08:03:26 INFO - PROCESS | 25141 | 08:03:28 INFO - PROCESS | 25141 | Cycle 1(1): loaded http://localhost:45201/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45201/tests/kraken/driver.html?testName=audio-oscillator) 08:03:29 INFO - PROCESS | 25141 | RSS: Main: 156930048 08:03:29 INFO - PROCESS | 25141 | 08:03:31 INFO - PROCESS | 25141 | Cycle 1(1): loaded http://localhost:45201/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45201/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:03:32 INFO - PROCESS | 25141 | RSS: Main: 156930048 08:03:32 INFO - PROCESS | 25141 | 08:03:35 INFO - PROCESS | 25141 | Cycle 1(1): loaded http://localhost:45201/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45201/tests/kraken/driver.html?testName=imaging-darkroom) 08:03:35 INFO - PROCESS | 25141 | RSS: Main: 156626944 08:03:35 INFO - PROCESS | 25141 | 08:03:39 INFO - PROCESS | 25141 | Cycle 1(1): loaded http://localhost:45201/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45201/tests/kraken/driver.html?testName=imaging-desaturate) 08:03:39 INFO - PROCESS | 25141 | RSS: Main: 157241344 08:03:39 INFO - PROCESS | 25141 | 08:03:42 INFO - PROCESS | 25141 | Cycle 1(1): loaded http://localhost:45201/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45201/tests/kraken/driver.html?testName=json-parse-financial) 08:03:43 INFO - PROCESS | 25141 | RSS: Main: 157601792 08:03:43 INFO - PROCESS | 25141 | 08:03:44 INFO - PROCESS | 25141 | Cycle 1(1): loaded http://localhost:45201/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45201/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:03:45 INFO - PROCESS | 25141 | RSS: Main: 157278208 08:03:45 INFO - PROCESS | 25141 | 08:03:47 INFO - PROCESS | 25141 | Cycle 1(1): loaded http://localhost:45201/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45201/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:03:47 INFO - PROCESS | 25141 | RSS: Main: 157114368 08:03:47 INFO - PROCESS | 25141 | 08:03:49 INFO - PROCESS | 25141 | Cycle 1(1): loaded http://localhost:45201/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45201/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:03:50 INFO - PROCESS | 25141 | RSS: Main: 156999680 08:03:50 INFO - PROCESS | 25141 | 08:03:52 INFO - PROCESS | 25141 | Cycle 1(1): loaded http://localhost:45201/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45201/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:03:53 INFO - PROCESS | 25141 | RSS: Main: 157552640 08:03:53 INFO - PROCESS | 25141 | 08:03:56 INFO - PROCESS | 25141 | Cycle 1(1): loaded http://localhost:45201/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45201/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:03:56 INFO - PROCESS | 25141 | RSS: Main: 157495296 08:03:56 INFO - PROCESS | 25141 | 08:03:58 INFO - PROCESS | 25141 | Cycle 1(1): loaded http://localhost:45201/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45201/tests/kraken/driver.html?testName=ai-astar) 08:03:58 INFO - PROCESS | 25141 | RSS: Main: 159113216 08:03:58 INFO - PROCESS | 25141 | 08:03:58 INFO - PROCESS | 25141 | __start_tp_report 08:03:58 INFO - PROCESS | 25141 | _x_x_mozilla_page_load 08:03:58 INFO - PROCESS | 25141 | _x_x_mozilla_page_load_details 08:03:58 INFO - PROCESS | 25141 | |i|pagename|runs| 08:03:58 INFO - PROCESS | 25141 | |0;ai-astar;108;112;102;112;111;110;101;111;110;112 08:03:58 INFO - PROCESS | 25141 | |1;audio-beat-detection;154;127;159;191;131;165;159;131;181;127 08:03:58 INFO - PROCESS | 25141 | |2;audio-dft;163;163;164;162;163;162;163;164;163;164 08:03:58 INFO - PROCESS | 25141 | |3;audio-fft;74;74;76;163;76;74;76;78;167;76 08:03:58 INFO - PROCESS | 25141 | |4;audio-oscillator;91;92;150;93;92;94;147;93;92;139 08:03:58 INFO - PROCESS | 25141 | |5;imaging-gaussian-blur;118;117;118;117;118;117;117;117;117;117 08:03:58 INFO - PROCESS | 25141 | |6;imaging-darkroom;147;147;147;146;147;147;146;148;148;146 08:03:58 INFO - PROCESS | 25141 | |7;imaging-desaturate;96;95;95;95;94;95;95;99;95;95 08:03:58 INFO - PROCESS | 25141 | |8;json-parse-financial;55;57;56;60;58;57;58;78;55;55 08:03:58 INFO - PROCESS | 25141 | |9;json-stringify-tinderbox;59;60;58;60;59;59;58;58;60;59 08:03:58 INFO - PROCESS | 25141 | |10;stanford-crypto-aes;73;81;73;80;76;74;74;73;75;74 08:03:58 INFO - PROCESS | 25141 | |11;stanford-crypto-ccm;130;118;113;115;117;123;116;116;128;137 08:03:58 INFO - PROCESS | 25141 | |12;stanford-crypto-pbkdf2;165;164;163;163;163;162;162;162;166;162 08:03:58 INFO - PROCESS | 25141 | |13;stanford-crypto-sha256-iterative;67;67;68;69;68;70;68;65;67;81 08:03:58 INFO - PROCESS | 25141 | __end_tp_report 08:03:58 INFO - PROCESS | 25141 | __start_cc_report 08:03:58 INFO - PROCESS | 25141 | _x_x_mozilla_cycle_collect,825 08:03:58 INFO - PROCESS | 25141 | __end_cc_report 08:03:58 INFO - PROCESS | 25141 | __startTimestamp1464015838779__endTimestamp 08:03:58 INFO - PROCESS | 25141 | 08:03:58 INFO - PROCESS | 25141 | ------- Summary: start ------- 08:03:58 INFO - PROCESS | 25141 | Number of tests: 14 08:03:58 INFO - PROCESS | 25141 | 08:03:58 INFO - PROCESS | 25141 | [#0] ai-astar Cycles:10 Average:108.90 Median:111.00 stddev:4.09 (3.7%) stddev-sans-first:4.33 08:03:58 INFO - PROCESS | 25141 | Values: 108.0 112.0 102.0 112.0 111.0 110.0 101.0 111.0 110.0 112.0 08:03:58 INFO - PROCESS | 25141 | 08:03:58 INFO - PROCESS | 25141 | [#1] audio-beat-detection Cycles:10 Average:152.50 Median:159.00 stddev:23.00 (14.5%) stddev-sans-first:24.39 08:03:58 INFO - PROCESS | 25141 | Values: 154.0 127.0 159.0 191.0 131.0 165.0 159.0 131.0 181.0 127.0 08:03:58 INFO - PROCESS | 25141 | 08:03:58 INFO - PROCESS | 25141 | [#2] audio-dft Cycles:10 Average:163.10 Median:163.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 08:03:58 INFO - PROCESS | 25141 | Values: 163.0 163.0 164.0 162.0 163.0 162.0 163.0 164.0 163.0 164.0 08:03:58 INFO - PROCESS | 25141 | 08:03:58 INFO - PROCESS | 25141 | [#3] audio-fft Cycles:10 Average:93.40 Median:76.00 stddev:37.77 (49.7%) stddev-sans-first:39.40 08:03:58 INFO - PROCESS | 25141 | Values: 74.0 74.0 76.0 163.0 76.0 74.0 76.0 78.0 167.0 76.0 08:03:58 INFO - PROCESS | 25141 | 08:03:58 INFO - PROCESS | 25141 | [#4] audio-oscillator Cycles:10 Average:108.30 Median:92.00 stddev:25.71 (27.9%) stddev-sans-first:26.49 08:03:58 INFO - PROCESS | 25141 | Values: 91.0 92.0 150.0 93.0 92.0 94.0 147.0 93.0 92.0 139.0 08:03:58 INFO - PROCESS | 25141 | 08:03:58 INFO - PROCESS | 25141 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 08:03:58 INFO - PROCESS | 25141 | Values: 118.0 117.0 118.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 08:03:58 INFO - PROCESS | 25141 | 08:03:58 INFO - PROCESS | 25141 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 08:03:58 INFO - PROCESS | 25141 | Values: 147.0 147.0 147.0 146.0 147.0 147.0 146.0 148.0 148.0 146.0 08:03:58 INFO - PROCESS | 25141 | 08:03:58 INFO - PROCESS | 25141 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.00 stddev:1.35 (1.4%) stddev-sans-first:1.41 08:03:58 INFO - PROCESS | 25141 | Values: 96.0 95.0 95.0 95.0 94.0 95.0 95.0 99.0 95.0 95.0 08:03:58 INFO - PROCESS | 25141 | 08:03:58 INFO - PROCESS | 25141 | [#8] json-parse-financial Cycles:10 Average:58.90 Median:57.50 stddev:6.90 (12.0%) stddev-sans-first:7.18 08:03:58 INFO - PROCESS | 25141 | Values: 55.0 57.0 56.0 60.0 58.0 57.0 58.0 78.0 55.0 55.0 08:03:58 INFO - PROCESS | 25141 | 08:03:58 INFO - PROCESS | 25141 | [#9] json-stringify-tinderbox Cycles:10 Average:59.00 Median:59.00 stddev:0.82 (1.4%) stddev-sans-first:0.87 08:03:58 INFO - PROCESS | 25141 | Values: 59.0 60.0 58.0 60.0 59.0 59.0 58.0 58.0 60.0 59.0 08:03:58 INFO - PROCESS | 25141 | 08:03:58 INFO - PROCESS | 25141 | [#10] stanford-crypto-aes Cycles:10 Average:75.30 Median:74.50 stddev:2.91 (3.9%) stddev-sans-first:2.96 08:03:58 INFO - PROCESS | 25141 | Values: 73.0 81.0 73.0 80.0 76.0 74.0 74.0 73.0 75.0 74.0 08:03:58 INFO - PROCESS | 25141 | 08:03:58 INFO - PROCESS | 25141 | [#11] stanford-crypto-ccm Cycles:10 Average:121.30 Median:120.50 stddev:7.92 (6.6%) stddev-sans-first:7.75 08:03:58 INFO - PROCESS | 25141 | Values: 130.0 118.0 113.0 115.0 117.0 123.0 116.0 116.0 128.0 137.0 08:03:58 INFO - PROCESS | 25141 | 08:03:58 INFO - PROCESS | 25141 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.20 Median:163.00 stddev:1.40 (0.9%) stddev-sans-first:1.32 08:03:58 INFO - PROCESS | 25141 | Values: 165.0 164.0 163.0 163.0 163.0 162.0 162.0 162.0 166.0 162.0 08:03:58 INFO - PROCESS | 25141 | 08:03:58 INFO - PROCESS | 25141 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:68.00 stddev:4.42 (6.5%) stddev-sans-first:4.63 08:03:58 INFO - PROCESS | 25141 | Values: 67.0 67.0 68.0 69.0 68.0 70.0 68.0 65.0 67.0 81.0 08:03:58 INFO - PROCESS | 25141 | -------- Summary: end -------- 08:03:58 INFO - PROCESS | 25141 | 08:03:59 INFO - TEST-INFO | 25141: exit 0 08:03:59 INFO - TEST-OK | kraken | took 60959ms 08:03:59 INFO - SUITE-END | took 1170s 08:03:59 INFO - Completed test suite (00:19:30) 08:03:59 INFO - javascript benchmark 08:03:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3294.2752594429226, 3356.7985920844735, 3378.375000624885, 3398.0825177202155, 3398.9320213595715, 5655.4061823508555, 5664.235328230688, 5685.715714214293, 5728.140778883169, 5732.369439361677, 5641.323041235048, 5704.1443783432505, 5738.081906894898, 5744.138379243115, 5753.165790960319, 5147.356580427447, 5196.714180720059, 5237.47625237477, 5270.578353731711, 5313.867153321159, 5053.620978426614, 5167.612429067816, 5313.867153321159, 5342.465753424646, 5348.358197016363, 5058.671186372892, 5115.309433226504, 5122.282880396748, 5124.92312615311, 5255.106631872572, 5105.744712764384, 5110.923336149961, 5124.590032797404, 5129.384473863123, 5141.280220769114, 4958.752062396866, 5041.6722913010535, 5050.217216331438, 5052.949470505285, 5088.084144853925, 5526.336839579236, 5537.750801213955, 5545.279113715232, 5560.360558535739, 5569.805056822992, 6083.087536869461, 6097.298810636789, 6099.847503812396, 6104.664243466652, 6111.327753947062, 5823.650580965155, 6059.909101363483, 6133.601315914496, 6138.232720909887, 6141.825783693951, 5618.85952851182, 5621.437856214387, 5621.550275977912, 5628.043232650419, 5667.574931880125, 6067.453929146398, 6084.5132389408745, 6114.6636934969, 6123.2652081750475, 6127.938720612826, 5904.763809447574, 5918.526517878559, 5947.732352044169, 5955.52355811534, 5986.910196347058, 6044.395560443921, 6046.881326954527, 6049.78825741097, 6053.334133245339, 6069.544784141119, 5911.76352945886, 6015.518758499397, 6032.607880487754, 6065.090236464477, 6115.240341084353, 5827.096799996008, 5891.734871930774, 5892.646441213541, 5896.056630939029, 5944.197533333031, 4474.686771925999, 4490.528494508029, 4493.4607847057905, 4505.639548836085, 4515.571020753023, 4051.554329023805, 4054.351303791379, 4100.487439070116, 4105.958940410617, 4138.420621113047, 5638.802641907513, 5778.306603207558, 5814.389489103668, 5886.499647529922, 5894.351621321651, 5948.10778383246, 5970.34326224115, 5974.880502389928, 5978.04351303798, 5980.43185897339, 5704.515116215085, 5772.0, 5866.50134738552, 5885.705714714247, 5911.083782013795, 5198.870028249324, 5199.662021968636, 5204.0372531081875, 5207.270982062514, 5229.294045303911, 6137.468918203611, 6337.271213810379, 6346.650934198571, 6350.968245158837, 6368.490520758328, 6058.394160583906, 6129.632222066691, 6143.139960405636, 6154.415330543591, 6161.568690191643, 6111.052786818051, 6129.816105516842, 6130.049842274455, 6141.07883817431, 6155.538334624832, 5778.306603207642, 5809.24479817621, 5823.213866128188, 5829.358770535153, 5845.152452894392, 5971.552133589911, 6005.789797357072, 6012.6993650316435, 6013.7293821779, 6036.456718895321, 5830.76676932918, 5863.530917526502, 5867.002609556301, 5881.05903055509, 5882.294124705063, 5764.221830052889, 5821.883562328814, 5848.561357898089, 5954.583179177416, 6010.87978240424, 5845.736941837543, 5873.471387575139, 5873.970630146822, 5880.0, 5881.05903055509, 5991.071383935497, 5994.820155395345, 6003.159557661844, 6004.099385092097, 6050.848728781815, 5606.495415412633, 5783.248177737036, 5819.185314056121, 5850.6782126981725, 5865.472107510344], "value": 5567.548090173472, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [611.5260672978444, 669.1100835888268, 675.9628220447875, 686.3102581905184, 706.3184027413545, 36927.446088308665, 37567.624323756754, 37827.0, 37934.62065379352, 37947.43078853819, 38666.0, 39126.41310380347, 39274.21451570967, 39298.60701392985, 39398.40902386467, 8561.443506172094, 8725.214730674237, 8743.912560874374, 8762.780930476725, 8777.95611021944, 8636.481811091324, 8980.236679882219, 9025.909740902573, 9037.41256818308, 9043.954780226122, 9025.95487022564, 9095.818083638324, 9099.181073703365, 9099.272058235325, 9107.863382049274, 8981.416207946462, 8989.235914947238, 9014.549272536347, 9050.818983620324, 9063.365564410495, 8931.97282312536, 8977.551122443852, 8978.191962723386, 9035.683751068682, 9049.2308153807, 33502.0, 39790.20419591621, 40666.39000414996, 40688.186236275404, 40848.79575602103, 3522.7181825453904, 3658.0306218852024, 3931.68546516278, 4155.563665815076, 4337.696361254713, 28174.85912570424, 28538.71461285381, 28776.424471510454, 28813.0, 29661.70338296611, 4342.435483387171, 4374.212641724488, 4382.846600368972, 4399.296112621997, 4464.6428285737065, 192604.0, 193441.0, 193786.0, 193984.0, 196802.0, 37087.07282317964, 37308.0, 39041.80479097643, 39517.80241098776, 39823.20353592912, 37681.81159094187, 37762.43356349657, 37802.24395512074, 37894.62105378966, 38005.0, 17556.912215439097, 17610.38363657266, 17788.733169002477, 17845.10774461298, 17870.642587148184, 14887.925560372345, 15017.098974061591, 15076.39694412233, 15105.093694378373, 15123.470678526199, 9229.815403692022, 9342.392744471588, 9344.859827102599, 9362.438253704799, 9425.481598512148, 3501.28223714138, 3583.802890841029, 3633.7274704396746, 3648.288583726148, 3648.635136486383, 1100.959593184449, 1103.7902798468265, 1111.366521082991, 1117.2681893359863, 1128.6896103571419, 32400.351992960008, 32452.513212301834, 32771.67228327734, 33814.830925845214, 33913.152171195914, 1233.0505510756668, 1279.5585522994552, 1281.7244292477162, 1297.1114786371365, 1368.2020268550837, 16259.51221463358, 17056.829431705773, 17193.0, 17310.567235819206, 17356.698247631477, 467062.0, 526905.0, 617410.0, 621438.0, 977574.0, 60344.39655603476, 60863.39136608577, 60889.69555152285, 61202.69398652978, 61410.0, 1556.704226197019, 1570.8193557740778, 1581.7943667323175, 1582.9762553561475, 1605.0, 30737.231569210948, 31338.373232535676, 33329.50005749867, 33459.33081338311, 33833.49249761305, 56171.71914140403, 56418.7179064102, 56682.43317566771, 56756.43243567677, 56818.0, 440983.0, 444093.0, 445124.0, 445406.0, 445848.0, 47333.52666473429, 47480.287795683784, 47734.0, 49252.2612160825, 49501.257481137094, 50196.49803501918, 51249.7437512825, 51425.48574514207, 51523.742381287855, 51892.0, 37840.62159378481, 38058.23883522259, 38109.4283585752, 40264.396034058926, 42344.5765542353, 40973.59026409698, 41083.1783364337, 41443.37834932418, 41533.58466415418, 42071.0, 41525.792371037955, 41919.580804191566, 42551.0, 42778.35832462453, 43030.78484607557, 34269.314613708084, 35589.28821423505, 36044.4593331095, 36091.458628120075, 36412.635873640924, 28048.43903121885, 28434.0, 28605.713942860304, 28722.425551488435, 28895.711042890143], "value": 19325.020038286424, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [401.64053172410684, 411.29108553958315, 413.9089400331926, 425.10727472308156, 430.7394026613899, 14608.19654918979, 19029.52426189346, 19663.31178408756, 20257.39227823164, 20317.984100794958, 19621.411357659294, 20112.0, 20349.59300813983, 20737.274195403163, 20917.686234706453, 5590.273264475612, 5647.604667673265, 5856.531477481792, 5880.353161152269, 5892.734826932777, 5673.177389278552, 5723.942760572403, 5753.597248192628, 5766.394528574502, 5787.160861675055, 5595.49640532352, 5656.886862262752, 5731.512821410185, 5756.568257380693, 5838.299404071496, 5701.116326969326, 5763.567732420085, 5765.135229715555, 5773.538116950634, 5792.594518383715, 5057.393112826448, 5160.974195129038, 5188.299579556749, 5210.6613070150315, 5243.2659427680155, 23312.3006309811, 23437.0, 23869.283921482383, 23871.0, 23908.163214287415, 2517.509085728284, 2574.897004119833, 2782.596523504101, 3096.8916087936814, 3221.8389080546112, 9569.90430095697, 10133.746656333577, 12486.375681215994, 14471.42114315426, 15416.075035497906, 1960.5490737130397, 1971.2213675598202, 2036.2771216218177, 2057.4650590846336, 2112.5669237806214, 66796.66601667009, 73114.0, 73964.63017684931, 76531.0, 77487.99999999943, 10239.18086553074, 11020.889791102147, 11080.889191108146, 11161.888381116247, 11223.382713950648, 15377.615559611098, 15384.30770615325, 15488.767668484981, 15529.0, 15540.378384864705, 8187.75436736887, 8251.257386835214, 8263.752087437386, 8311.33509319265, 8341.624626891804, 8022.638981245858, 8119.675212991532, 8157.510549367057, 8193.180681931879, 8257.669693212325, 4743.217369134054, 4751.6500866889455, 4783.306420568998, 4851.660383773102, 4865.56209941107, 1884.9161732004152, 1922.3175772600805, 1974.2004488182308, 2013.6073465674347, 2022.9089690963647, 1048.6749107776614, 1097.5938902606088, 1128.5767837061103, 1136.176272202663, 1165.5629139072848, 16786.32854685799, 18692.626147477247, 18867.622647547247, 19569.804301957083, 20955.8952205238, 1088.2491081153978, 1100.5212732461405, 1159.5535718748342, 1171.420147027227, 1202.5911190195375, 11258.268212566158, 11275.267107637977, 11282.605108821315, 11395.974362307266, 11429.828552571718, 388133.0, 585511.0, 616835.0, 639997.0, 647485.0, 100164.0, 102853.48573257236, 103026.0, 104158.0, 104465.0, 1123.2418117770471, 1151.8099513580166, 1153.5270539078938, 1169.8245263210417, 1176.0474016046858, 18067.51875520976, 18109.63780724352, 18197.54506137357, 18206.271749129886, 18365.724514132566, 40494.0, 41066.0, 41462.1707565841, 42509.57490425056, 42753.35869961891, 56578.43421565896, 61765.0, 62377.68811155915, 62525.0, 63412.68293658502, 8484.957575212084, 8610.526421046903, 8686.869696954423, 8832.955835220782, 8882.733517994471, 12869.485220591447, 13895.791563126764, 14154.646133846736, 14311.642208944859, 14327.78508322355, 12419.068569857478, 12487.625371238877, 12631.87368126307, 12697.619071427873, 12855.16441431304, 8076.555789431638, 8251.502930902552, 11818.940905295418, 11959.581414650445, 12411.131220814455, 8296.045954715284, 8357.414980951275, 8576.485410875368, 8676.956615216883, 8758.167974042455, 12724.109312348046, 12905.741885162057, 12965.15726477776, 13453.46186152543, 13607.387667555182, 12585.748285034431, 12599.559015434415, 12599.811002835148, 12684.492620295085, 12687.302198379179], "value": 9610.629171555871, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1541.4681934732519, 1557.0657605436736, 1745.9476215713532, 1896.6301571193624, 1896.649119912817, 7460.515066520672, 8065.637046332914, 8217.589120543978, 8434.325253979674, 8476.618552165144, 8101.230383113595, 8185.795355116125, 8268.29719473844, 8293.295069919064, 8298.460600060991, 2358.6108292131776, 2373.845700029501, 2386.3914701751114, 2387.761223877607, 2387.868667223302, 2263.739669937962, 2288.2220045184636, 2305.354500739787, 2308.134449581407, 2350.4241460842118, 2280.612295909691, 2301.2866011536476, 2311.167979527369, 2366.905323787055, 2375.1805627058725, 2270.375646697155, 2280.2019293247395, 2293.472501324696, 2294.575503531852, 2361.350628577155, 2314.36355002374, 2330.918417855367, 2338.356951838241, 2343.7070366204225, 2344.4256157241584, 8443.915560844374, 8449.32405407566, 8453.196946290092, 8512.31901447889, 8526.57367131641, 5105.617078719111, 5144.511271429208, 5211.530962213381, 5235.450277720823, 5250.97374513125, 3423.6747508986605, 3423.96576034239, 3524.242287908112, 3574.767640103411, 3597.928041439183, 1200.7838589053968, 1222.1078612612841, 1253.3921048291572, 2222.3540931074463, 2314.143766806276, 11345.149113816497, 11557.133215008907, 11621.825672614917, 11622.244554103956, 11622.59320923772, 4318.481782186095, 4329.069250111241, 4345.152695224464, 4361.0, 4435.889102772392, 9397.389169703947, 9421.576029078708, 9441.0, 9445.763855903657, 9451.574679139456, 5162.432132465426, 5172.27588137661, 5181.041507321158, 5199.272101905736, 5204.037253108111, 4360.062586543908, 4602.516735742699, 4674.95325046752, 4691.366665500113, 4835.443923948791, 3771.113788259757, 3813.6567708905777, 3900.941485877714, 3936.7244292899795, 3958.4853968984426, 1133.280366966982, 1151.8560179977503, 1154.9769004619861, 1170.1808733886314, 1174.7180676637715, 1043.5721354244724, 1087.923845330835, 1103.365564800227, 1111.699841042914, 1113.966581002555, 5865.560082993792, 6115.082737589397, 6150.3849615039035, 6183.752649894044, 6265.0, 987.3335498538457, 1051.8106740786732, 1055.5302890213782, 1064.0370464729433, 1073.9463026848625, 4094.9385759213637, 4161.396597493346, 4183.205191013698, 4193.391958166048, 4250.574942505787, 10209.591616335412, 10443.68668939933, 10601.522931468102, 10614.946925265478, 10632.25574209798, 10072.798544029078, 10337.534810933526, 10416.635417760343, 10460.058594726359, 10471.952804719467, 8038.919610803817, 8070.677172913018, 8202.835943281101, 8231.42380033392, 8263.256306932284, 5880.206172166702, 5936.703164841654, 5982.252218472691, 5984.115003773797, 5999.370066143167, 8774.38579299443, 8867.379283450096, 8951.283897288331, 8979.14698103679, 8998.775030624287, 8914.28685705155, 8976.326775491734, 9054.547272636473, 9113.954430227806, 9160.908390916005, 6797.89803152963, 7340.376068034277, 7425.480216384801, 7558.093028836574, 7582.582957937367, 8052.355811535181, 8062.395320351115, 8084.353251739729, 8115.229053239933, 8132.024157100949, 7024.578525288499, 7226.313500217471, 7255.09311336083, 7314.0, 7359.411247100326, 7093.858122837411, 7131.393831524171, 7342.339189472973, 7380.335769780745, 7394.704211831467, 6818.693158807766, 6828.248892621907, 6829.975503674488, 6850.691718872762, 6859.897101543381, 5231.738413079254, 5270.104082306094, 5364.6512976656395, 5456.072467680583, 5562.638428502134, 5068.087744206078, 5140.717260550706, 5228.37259528859, 5264.894702106013, 5315.3090098286975], "value": 4607.078788679561, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.602581006033, 343.3013816882644, 344.28217167206367, 346.0431905780519, 351.978881267124, 6540.117084193633, 6582.144321238238, 6592.604443733373, 6648.06927030215, 6683.832904177398, 6583.967080164604, 6639.435647969928, 6656.334366563341, 6661.933380666192, 6684.264730879611, 4698.036902435001, 4763.356946812188, 4947.653664243504, 4960.404751429834, 4960.759810047488, 4929.926051109236, 4946.653734238605, 4947.03532811102, 4952.455229924705, 4958.6281028922795, 4909.5581397674205, 4917.606591472691, 4929.4824043475455, 4929.704217746947, 4929.950700492985, 4911.75441227939, 4918.631102667278, 4922.606191504671, 4934.185859333224, 4946.208606622923, 4274.358846173099, 4275.893102672427, 4284.571542845691, 4285.014446677282, 4289.442372491588, 6162.291336496315, 6299.149614802035, 6347.428731414148, 6356.0, 6367.904481432783, 5728.112142617901, 5780.971095144498, 5787.3923238059815, 5792.189093526909, 5799.594028418012, 6925.342092501204, 6932.133483314586, 6935.6878940447805, 6940.514164008521, 6959.61722105284, 4740.3837501124635, 4766.38037055184, 4776.522347765231, 4778.474367819537, 4779.139754844126, 7245.347918687344, 7277.199508054163, 7284.380827629658, 7296.890546641805, 7304.393033532614, 4781.760911954389, 4852.56326930578, 4853.12643724126, 4867.683600565952, 4878.682885612424, 4906.1414252505665, 4925.433575138905, 4927.630427717864, 4933.186024306021, 4938.160512712848, 5657.830265092054, 5731.971340143273, 5743.310802703702, 5747.080467125324, 5768.855778605484, 7038.436925045984, 7045.401140903081, 7050.717971281091, 7053.329933656294, 7055.858882822417, 1732.41098026669, 1747.3098126240063, 1747.7028905086165, 1756.1570446185901, 1757.1038770227021, 1102.404701461202, 1128.1313388690662, 1134.8184290513477, 1166.445938179358, 1169.5438778876246, 6781.796546103625, 6848.178218613798, 6864.1762988440705, 6876.896846547305, 6883.483738719616, 6984.196817365966, 7237.565746055148, 7245.239249878687, 7278.963605182046, 7287.781366558906, 6673.833154171185, 6869.622170780655, 6874.003269525891, 6885.586864788129, 6893.517453778288, 3932.311845427039, 3938.4092386142306, 3957.08986933007, 3957.762534247954, 3971.2057588481844, 7626.313631773167, 7627.8855817162785, 7660.042494688164, 7668.041494813148, 7672.427152433737, 7340.4127669786285, 7539.962300188464, 7541.057367829021, 7543.396528277724, 7561.621918904033, 7608.961955190189, 7667.424943129287, 7667.8849817252785, 7667.923320766721, 7669.7315593953945, 7252.492325537161, 7289.854202916018, 7307.26927307265, 7309.963450182715, 7316.524425912298, 7196.460265480006, 7204.171520275236, 7237.927620723725, 7241.167265764505, 7246.963765181351, 7338.11942566874, 7587.203343648837, 7590.1650818411035, 7635.312821846061, 7641.235876412315, 4866.926996095132, 4925.310456536159, 4946.985867897, 4986.850394488171, 5003.224500202475, 7273.127224732854, 7305.41556675454, 7312.597807120659, 7316.451266154953, 7321.597312147883, 7034.261402552863, 7068.787936361918, 7096.858062838611, 7107.609081500567, 7136.107986501687, 6891.724331026903, 7008.894866576903, 7011.3339232772805, 7062.823429414306, 7090.0, 6930.168379794457, 6940.583564986117, 6941.826454338682, 6963.1644202696, 6981.3367730065565, 7107.715691372287, 7108.289171082851, 7113.146422429341, 7188.4968052235845, 7216.278372162742, 6875.89686154698, 6905.136857892763, 6915.273896240822, 6920.515563910478, 6929.688164032731], "value": 5263.668838509584, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [824.7072289337285, 856.6616186606294, 873.8558137907246, 878.8725634782957, 907.1291560102302, 14547.78178327326, 14607.196604186793, 14711.117332960002, 14716.117032978029, 14848.1091134532, 13697.58907232782, 13970.37133329, 14046.29768511573, 14063.578092657237, 14065.507707230248, 763.3053920931953, 891.5854127830557, 916.2212119698237, 917.6329468212735, 919.783850795066, 903.0653273861554, 913.5934509143434, 921.0559176843756, 922.8615707643874, 923.1276443760648, 960.3805545423198, 961.0149596663406, 970.7864269860655, 973.1193270090579, 973.3916302311055, 955.4506158958627, 962.0091305954878, 962.7015625156224, 963.1091240602415, 963.4075043848053, 696.6969368324795, 697.9860402791916, 701.113091938698, 704.9612271325075, 707.4552594502204, 15004.0, 15119.546413607499, 15122.848771512254, 15177.392904283815, 15222.543323700307, 14268.286585670676, 14558.92720536401, 14644.267786610733, 14694.191819449927, 14765.852341476555, 11545.763389288535, 11601.0, 11686.532538698442, 11772.88227117735, 11798.941005294919, 4033.737807042533, 4038.899027524306, 4146.274401979642, 4206.095689426788, 4206.348016057516, 55740.0, 55998.0, 56055.71972140154, 56195.71902140504, 57877.0, 11467.369294688706, 11546.712511333324, 11551.595694150665, 11715.472803723853, 11775.05799536035, 20121.49696257576, 20298.18807247723, 20460.0, 21063.26278580273, 21268.0, 8631.913680863237, 8678.262347700389, 8767.298616110696, 8780.956095219482, 8902.777430564158, 4790.784414701347, 4825.879353016133, 4882.267659851051, 4915.287283343895, 4977.104121258209, 3259.4133056050136, 3337.1823903143886, 3347.782394144373, 3348.0290715692663, 3356.848941797625, 621.5052798020768, 627.6108812536256, 638.2468686949444, 640.702073535808, 642.5084810120262, 799.6081919859344, 802.9116797152309, 803.9276465118168, 830.9958450207711, 837.8282452097305, 9168.862467062865, 9430.575624096795, 9519.23846092311, 9521.904780952102, 9662.08210220028, 678.7285085965653, 788.129601336949, 799.0690845165434, 814.3810703865105, 849.9277561407226, 4505.864824055284, 4524.751138687404, 4554.0664163847, 4580.335851301609, 4611.515790841913, 59801.40198597958, 60421.0, 60944.08583871245, 61244.38755612476, 61439.0, 54793.0, 55563.0, 56351.0, 56586.15120773192, 56978.43021569814, 50783.74608126936, 50884.0, 51715.74142129265, 51986.740066299426, 52218.47781522136, 8540.27407670355, 8895.955520222358, 9023.458592484472, 9081.77295567616, 9085.0, 39029.609703903734, 40066.797996060166, 40108.59891401049, 40977.0, 41168.0, 46400.0, 47238.76380618075, 49702.0, 50543.0, 50595.0, 10974.231803773979, 11206.215564910379, 11310.208285419942, 11313.943430282796, 11618.186726929034, 12479.251244925334, 12479.376031198586, 12542.372881356077, 12588.244705317711, 12631.81052284198, 11015.449227538431, 11092.223544351818, 11590.42047897585, 11641.359725214856, 12179.512819487121, 11656.825147622962, 11709.531618735497, 11811.232269902428, 11915.0, 12011.219270747373, 13463.394147263201, 13640.0, 13906.721865562835, 14209.573712788218, 14273.000889937604, 10054.0, 10514.94742526313, 10615.416152111398, 10688.89311106879, 10776.030157285883, 9457.38526995743, 9717.611295548098, 9779.943804858754, 9854.310198286052, 9892.258080644124], "value": 7015.318010457921, "unit": "score"}], "name": "dromaeo_css", "value": 7485.52485909268, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 112.0, 102.0, 112.0, 111.0, 110.0, 101.0, 111.0, 110.0, 112.0], "value": 108.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 127.0, 159.0, 191.0, 131.0, 165.0, 159.0, 131.0, 181.0, 127.0], "value": 152.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 164.0, 162.0, 163.0, 162.0, 163.0, 164.0, 163.0, 164.0], "value": 163.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 76.0, 163.0, 76.0, 74.0, 76.0, 78.0, 167.0, 76.0], "value": 93.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 150.0, 93.0, 92.0, 94.0, 147.0, 93.0, 92.0, 139.0], "value": 108.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 146.0, 148.0, 148.0, 146.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 99.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 57.0, 56.0, 60.0, 58.0, 57.0, 58.0, 78.0, 55.0, 55.0], "value": 58.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 58.0, 60.0, 59.0, 59.0, 58.0, 58.0, 60.0, 59.0], "value": 59.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 81.0, 73.0, 80.0, 76.0, 74.0, 74.0, 73.0, 75.0, 74.0], "value": 75.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 118.0, 113.0, 115.0, 117.0, 123.0, 116.0, 116.0, 128.0, 137.0], "value": 121.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 163.0, 163.0, 163.0, 162.0, 162.0, 162.0, 166.0, 162.0], "value": 163.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 68.0, 69.0, 68.0, 70.0, 68.0, 65.0, 67.0, 81.0], "value": 69.0, "unit": "score"}], "name": "kraken", "value": 1532.4999999999998, "alertThreshold": 2.0}]} 08:04:00 INFO - Return code: 0 08:04:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:04:00 ERROR - # TBPL SUCCESS # 08:04:00 INFO - Running post-action listener: _resource_record_post_action 08:04:00 INFO - Running post-run listener: _resource_record_post_run 08:04:01 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 498356224; Read time: 0; Write time: 441588 08:04:01 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 248348672; Read time: 0; Write time: 310944 08:04:01 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 249409536; Read time: 0; Write time: 130644 08:04:01 INFO - Running post-run listener: _upload_blobber_files 08:04:01 INFO - Blob upload gear active. 08:04:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:04:01 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 08:04:01 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'] 08:04:01 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 08:04:01 INFO - (blobuploader) - INFO - Open directory for files ... 08:04:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:04:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:04:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:04:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:04:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:04:02 INFO - (blobuploader) - INFO - Done attempting. 08:04:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:04:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:04:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:04:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:04:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:04:03 INFO - (blobuploader) - INFO - Done attempting. 08:04:03 INFO - (blobuploader) - INFO - Iteration through files over. 08:04:03 INFO - Return code: 0 08:04:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:04:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:04:03 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/29b4a4bd7d7d66e5adf364652622115683b7c2022a441d80cca1240c1ea8ccc649fe731054eb420bbbcb466339414771ff426ca2439b91dd96b6c529995dc73b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/463ced48fd7b88522a2327533f525a7803975f23dc2ee8f706ef9aab34c38319c0f0ee4b58133bd753ee4f01c932e71782c786c904522eca5bc1a4758230f5b0"} 08:04:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:04:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:04:03 INFO - Contents: 08:04:03 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/29b4a4bd7d7d66e5adf364652622115683b7c2022a441d80cca1240c1ea8ccc649fe731054eb420bbbcb466339414771ff426ca2439b91dd96b6c529995dc73b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/463ced48fd7b88522a2327533f525a7803975f23dc2ee8f706ef9aab34c38319c0f0ee4b58133bd753ee4f01c932e71782c786c904522eca5bc1a4758230f5b0"} 08:04:03 INFO - Running post-run listener: copy_logs_to_upload_dir 08:04:03 INFO - Copying logs to upload dir... 08:04:03 INFO - mkdir: /builds/slave/test/build/upload/logs 08:04:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.962663 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-05-23 08:04:01.924285) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-23 08:04:01.931907) ========= 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=c6927cf182745ad25b1d38b9000001fe-1464008973.203001-1874161468 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/29b4a4bd7d7d66e5adf364652622115683b7c2022a441d80cca1240c1ea8ccc649fe731054eb420bbbcb466339414771ff426ca2439b91dd96b6c529995dc73b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/463ced48fd7b88522a2327533f525a7803975f23dc2ee8f706ef9aab34c38319c0f0ee4b58133bd753ee4f01c932e71782c786c904522eca5bc1a4758230f5b0"} build_url:https://queue.taskcluster.net/v1/task/RGErAEGHSFmeSM9oVvVPCQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011482 build_url: 'https://queue.taskcluster.net/v1/task/RGErAEGHSFmeSM9oVvVPCQ/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/29b4a4bd7d7d66e5adf364652622115683b7c2022a441d80cca1240c1ea8ccc649fe731054eb420bbbcb466339414771ff426ca2439b91dd96b6c529995dc73b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/463ced48fd7b88522a2327533f525a7803975f23dc2ee8f706ef9aab34c38319c0f0ee4b58133bd753ee4f01c932e71782c786c904522eca5bc1a4758230f5b0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-23 08:04:01.960273) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 08:04:01.960651) ========= 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=c6927cf182745ad25b1d38b9000001fe-1464008973.203001-1874161468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004492 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 08:04:02.041241) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-23 08:04:02.044588) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-23 08:04:02.044893) ========= ========= Total master_lag: 0.19 =========