builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-063 starttime: 1464172082.36 results: success (0) buildid: 20160525004047 builduid: 07a7102eb5e9489dbdb378a34d8aac30 revision: 14079be66b19b1fa8c60fa34239bcff57ca51ab0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-25 03:28:02.364702) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-25 03:28:02.365175) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-25 03:28:02.365459) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-25 03:28:02.381043) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 03:28:02.381394) ========= 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=33d5923976266a1c518c4bf7000001ab-1464172082.218159-1705217645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-25 03:28:02-- 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% 223M=0s 2016-05-25 03:28:03 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.328353 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 03:28:02.723373) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 03:28:02.726761) ========= 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=33d5923976266a1c518c4bf7000001ab-1464172082.218159-1705217645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023738 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 03:28:02.777760) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 03:28:02.778151) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 14079be66b19b1fa8c60fa34239bcff57ca51ab0 --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 14079be66b19b1fa8c60fa34239bcff57ca51ab0 --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=33d5923976266a1c518c4bf7000001ab-1464172082.218159-1705217645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-25 03:28:03,346 truncating revision to first 12 chars 2016-05-25 03:28:03,346 Setting DEBUG logging. 2016-05-25 03:28:03,346 attempt 1/10 2016-05-25 03:28:03,346 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/14079be66b19?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-25 03:28:03,615 unpacking tar archive at: mozilla-aurora-14079be66b19/testing/mozharness/ program finished with exit code 0 elapsedTime=0.552497 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 03:28:03.347149) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-25 03:28:03.347521) ========= script_repo_revision: 14079be66b19b1fa8c60fa34239bcff57ca51ab0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-25 03:28:03.347967) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-25 03:28:03.348241) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-25 03:28:03.357806) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-05-25 03:28:03.358141) ========= /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=33d5923976266a1c518c4bf7000001ab-1464172082.218159-1705217645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:28:04 INFO - MultiFileLogger online at 20160525 03:28:04 in /builds/slave/test 03:28:04 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 03:28:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:28:04 INFO - {'append_to_log': False, 03:28:04 INFO - 'base_work_dir': '/builds/slave/test', 03:28:04 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:28:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:28:04 INFO - 'branch': 'Mozilla-Aurora', 03:28:04 INFO - 'buildbot_json_path': 'buildprops.json', 03:28:04 INFO - 'config_files': ('talos/linux_config.py',), 03:28:04 INFO - 'default_actions': ('clobber', 03:28:04 INFO - 'read-buildbot-config', 03:28:04 INFO - 'download-and-extract', 03:28:04 INFO - 'populate-webroot', 03:28:04 INFO - 'create-virtualenv', 03:28:04 INFO - 'install', 03:28:04 INFO - 'run-tests'), 03:28:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:28:04 INFO - 'download_minidump_stackwalk': True, 03:28:04 INFO - 'download_symbols': 'ondemand', 03:28:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:28:04 INFO - 'tooltool.py': '/tools/tooltool.py', 03:28:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:28:04 INFO - '/tools/misc-python/virtualenv.py')}, 03:28:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:28:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:28:04 INFO - 'installer_path': 'installer.exe', 03:28:04 INFO - 'log_level': 'info', 03:28:04 INFO - 'log_name': 'talos', 03:28:04 INFO - 'log_to_console': True, 03:28:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:28:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:28:04 INFO - 'opt_config_files': (), 03:28:04 INFO - 'pip_index': False, 03:28:04 INFO - 'sps_profile': False, 03:28:04 INFO - 'sps_profile_interval': 0, 03:28:04 INFO - 'suite': 'dromaeojs-e10s', 03:28:04 INFO - 'system_bits': '32', 03:28:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:28:04 INFO - 'title': 'talos-linux64-ix-063', 03:28:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:28:04 INFO - 'use_talos_json': True, 03:28:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:28:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:28:04 INFO - 'work_dir': 'build'} 03:28:04 INFO - ##### 03:28:04 INFO - ##### Running clobber step. 03:28:04 INFO - ##### 03:28:04 INFO - Running pre-action listener: _resource_record_pre_action 03:28:04 INFO - Running main action method: clobber 03:28:04 INFO - rmtree: /builds/slave/test/build 03:28:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:28:04 INFO - Running post-action listener: _resource_record_post_action 03:28:04 INFO - ##### 03:28:04 INFO - ##### Running read-buildbot-config step. 03:28:04 INFO - ##### 03:28:04 INFO - Running pre-action listener: _resource_record_pre_action 03:28:04 INFO - Running main action method: read_buildbot_config 03:28:04 INFO - Using buildbot properties: 03:28:04 INFO - { 03:28:04 INFO - "project": "", 03:28:04 INFO - "product": "firefox", 03:28:04 INFO - "script_repo_revision": "production", 03:28:04 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:28:04 INFO - "repository": "", 03:28:04 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:28:04 INFO - "buildid": "20160525004047", 03:28:04 INFO - "stage_platform": "linux64-pgo", 03:28:04 INFO - "basedir": "/builds/slave/test", 03:28:04 INFO - "nightly_build": "True", 03:28:04 INFO - "buildnumber": 287, 03:28:04 INFO - "slavename": "talos-linux64-ix-063", 03:28:04 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:28:04 INFO - "platform": "ubuntu64_hw", 03:28:04 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:28:04 INFO - "branch": "mozilla-aurora", 03:28:04 INFO - "repo_path": "releases/mozilla-aurora", 03:28:04 INFO - "revision": "14079be66b19b1fa8c60fa34239bcff57ca51ab0", 03:28:04 INFO - "pgo_build": "True", 03:28:04 INFO - "builduid": "07a7102eb5e9489dbdb378a34d8aac30", 03:28:04 INFO - "slavebuilddir": "test" 03:28:04 INFO - } 03:28:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/Q9k4nuG4RIKO7ZNl-CLMvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 03:28:04 INFO - Running post-action listener: _resource_record_post_action 03:28:04 INFO - ##### 03:28:04 INFO - ##### Running download-and-extract step. 03:28:04 INFO - ##### 03:28:04 INFO - Running pre-action listener: _resource_record_pre_action 03:28:04 INFO - Running main action method: download_and_extract 03:28:04 INFO - mkdir: /builds/slave/test/build/tests 03:28:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:04 INFO - https://queue.taskcluster.net/v1/task/Q9k4nuG4RIKO7ZNl-CLMvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:28:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q9k4nuG4RIKO7ZNl-CLMvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:28:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q9k4nuG4RIKO7ZNl-CLMvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:28:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q9k4nuG4RIKO7ZNl-CLMvQ/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 03:28:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q9k4nuG4RIKO7ZNl-CLMvQ/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 03:28:05 INFO - Downloaded 1361 bytes. 03:28:05 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:28:05 INFO - Using the following test package requirements: 03:28:05 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:28:05 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:28:05 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:28:05 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:28:05 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:28:05 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:28:05 INFO - u'jsshell-linux-x86_64.zip'], 03:28:05 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:28:05 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:28:05 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:28:05 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:28:05 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:28:05 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:28:05 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:28:05 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:28:05 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:28:05 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:28:05 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:28:05 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:28:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:05 INFO - https://queue.taskcluster.net/v1/task/Q9k4nuG4RIKO7ZNl-CLMvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:28:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q9k4nuG4RIKO7ZNl-CLMvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:28:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q9k4nuG4RIKO7ZNl-CLMvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:28:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q9k4nuG4RIKO7ZNl-CLMvQ/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 03:28:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q9k4nuG4RIKO7ZNl-CLMvQ/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 03:28:06 INFO - Downloaded 24136369 bytes. 03:28:06 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'] 03:28:06 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 03:28:07 INFO - Return code: 0 03:28:07 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 03:28:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:07 INFO - https://queue.taskcluster.net/v1/task/Q9k4nuG4RIKO7ZNl-CLMvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:28:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q9k4nuG4RIKO7ZNl-CLMvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:28:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q9k4nuG4RIKO7ZNl-CLMvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:28:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q9k4nuG4RIKO7ZNl-CLMvQ/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 03:28:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q9k4nuG4RIKO7ZNl-CLMvQ/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 03:28:08 INFO - Downloaded 24136369 bytes. 03:28:08 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'] 03:28:08 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 03:28:12 INFO - Return code: 0 03:28:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:12 INFO - https://queue.taskcluster.net/v1/task/Q9k4nuG4RIKO7ZNl-CLMvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:28:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q9k4nuG4RIKO7ZNl-CLMvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:28:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q9k4nuG4RIKO7ZNl-CLMvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:28:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q9k4nuG4RIKO7ZNl-CLMvQ/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 03:28:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q9k4nuG4RIKO7ZNl-CLMvQ/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 03:28:13 INFO - Downloaded 10840145 bytes. 03:28:13 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'] 03:28:13 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 03:28:14 INFO - Return code: 0 03:28:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:14 INFO - https://queue.taskcluster.net/v1/task/Q9k4nuG4RIKO7ZNl-CLMvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:28:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q9k4nuG4RIKO7ZNl-CLMvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:28:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q9k4nuG4RIKO7ZNl-CLMvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:28:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q9k4nuG4RIKO7ZNl-CLMvQ/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 03:28:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q9k4nuG4RIKO7ZNl-CLMvQ/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 03:28:15 INFO - Downloaded 62719830 bytes. 03:28:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Q9k4nuG4RIKO7ZNl-CLMvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:28:15 INFO - mkdir: /builds/slave/test/properties 03:28:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:28:15 INFO - Writing to file /builds/slave/test/properties/build_url 03:28:15 INFO - Contents: 03:28:15 INFO - build_url:https://queue.taskcluster.net/v1/task/Q9k4nuG4RIKO7ZNl-CLMvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:28:16 INFO - Running post-action listener: _resource_record_post_action 03:28:16 INFO - Running post-action listener: set_extra_try_arguments 03:28:16 INFO - ##### 03:28:16 INFO - ##### Running populate-webroot step. 03:28:16 INFO - ##### 03:28:16 INFO - Running pre-action listener: _resource_record_pre_action 03:28:16 INFO - Running main action method: populate_webroot 03:28:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:28:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:28:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:28:16 INFO - '--tppagecycles', 03:28:16 INFO - '7'], 03:28:16 INFO - 'tests': ['tsvgm']}}, 03:28:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:28:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:28:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:28:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:28:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:28:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:28:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:16 INFO - 'talos_options': ['--disable-e10s'], 03:28:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:28:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:28:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:16 INFO - 'talos_options': ['--disable-e10s'], 03:28:16 INFO - 'tests': ['damp', 'tps']}, 03:28:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:16 INFO - 'tests': ['damp', 'tps']}, 03:28:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:28:16 INFO - 'tests': ['dromaeo_dom']}, 03:28:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:28:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:28:16 INFO - 'tests': ['a11yr', 03:28:16 INFO - 'ts_paint', 03:28:16 INFO - 'tpaint', 03:28:16 INFO - 'sessionrestore', 03:28:16 INFO - 'sessionrestore_no_auto_restore', 03:28:16 INFO - 'tabpaint']}, 03:28:16 INFO - 'other-e10s': {'tests': ['a11yr', 03:28:16 INFO - 'ts_paint', 03:28:16 INFO - 'tpaint', 03:28:16 INFO - 'sessionrestore', 03:28:16 INFO - 'sessionrestore_no_auto_restore', 03:28:16 INFO - 'tabpaint']}, 03:28:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:28:16 INFO - 'ts_paint', 03:28:16 INFO - 'tpaint', 03:28:16 INFO - 'sessionrestore', 03:28:16 INFO - 'sessionrestore_no_auto_restore', 03:28:16 INFO - 'tabpaint']}, 03:28:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:28:16 INFO - 'ts_paint', 03:28:16 INFO - 'tpaint', 03:28:16 INFO - 'sessionrestore', 03:28:16 INFO - 'sessionrestore_no_auto_restore', 03:28:16 INFO - 'tabpaint']}, 03:28:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:28:16 INFO - 'tests': ['a11yr', 03:28:16 INFO - 'ts_paint', 03:28:16 INFO - 'tpaint', 03:28:16 INFO - 'sessionrestore', 03:28:16 INFO - 'sessionrestore_no_auto_restore', 03:28:16 INFO - 'tabpaint']}, 03:28:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:28:16 INFO - 'tests': ['a11yr', 03:28:16 INFO - 'ts_paint', 03:28:16 INFO - 'tpaint', 03:28:16 INFO - 'sessionrestore', 03:28:16 INFO - 'sessionrestore_no_auto_restore', 03:28:16 INFO - 'tabpaint']}, 03:28:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:28:16 INFO - 'tests': ['tsvgx', 03:28:16 INFO - 'tsvgr_opacity', 03:28:16 INFO - 'tart', 03:28:16 INFO - 'tscrollx', 03:28:16 INFO - 'cart']}, 03:28:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:28:16 INFO - 'tsvgr_opacity', 03:28:16 INFO - 'tart', 03:28:16 INFO - 'tscrollx', 03:28:16 INFO - 'cart']}, 03:28:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:16 INFO - 'talos_options': ['--disable-e10s'], 03:28:16 INFO - 'tests': ['tp5o']}, 03:28:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:16 INFO - 'tests': ['tp5o']}, 03:28:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:16 INFO - 'talos_options': ['--disable-e10s', 03:28:16 INFO - '--xperf_path', 03:28:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:28:16 INFO - 'tests': ['tp5n']}, 03:28:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:16 INFO - 'talos_options': ['--xperf_path', 03:28:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:28:16 INFO - 'tests': ['tp5n']}}, 03:28:16 INFO - 'talos.zip': {'path': '', 03:28:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:28:16 INFO - Running post-action listener: _resource_record_post_action 03:28:16 INFO - ##### 03:28:16 INFO - ##### Running create-virtualenv step. 03:28:16 INFO - ##### 03:28:16 INFO - Running pre-action listener: _resource_record_pre_action 03:28:16 INFO - Running main action method: create_virtualenv 03:28:16 INFO - Creating virtualenv /builds/slave/test/build/venv 03:28:16 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 03:28:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:28:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:28:16 INFO - Using real prefix '/usr' 03:28:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:28:16 INFO - Installing distribute.............................................................................................................................................................................................done. 03:28:18 INFO - Installing pip.................done. 03:28:18 INFO - Return code: 0 03:28:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:28:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4689c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1162410>, '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 0x1163310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11637a0>, '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': '33d5923976266a1c518c4bf7000001ab-1464172082.218159-1705217645', '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 03:28:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:28:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:28:18 INFO - Using env: {'DISPLAY': ':0', 03:28:18 INFO - 'HOME': '/home/cltbld', 03:28:18 INFO - 'LANG': 'en_US.UTF-8', 03:28:18 INFO - 'LANGUAGE': 'en_US:en', 03:28:18 INFO - 'LOGNAME': 'cltbld', 03:28:18 INFO - 'MAIL': '/var/mail/cltbld', 03:28:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:18 INFO - 'MOZ_NO_REMOTE': '1', 03:28:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:18 INFO - 'NO_EM_RESTART': '1', 03:28:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:18 INFO - 'PWD': '/builds/slave/test', 03:28:18 INFO - 'SHELL': '/bin/bash', 03:28:18 INFO - 'SHLVL': '1', 03:28:18 INFO - 'TERM': 'linux', 03:28:18 INFO - 'TMOUT': '86400', 03:28:18 INFO - 'USER': 'cltbld', 03:28:18 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464172082.218159-1705217645', 03:28:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:18 INFO - '_': '/tools/buildbot/bin/python'} 03:28:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:19 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 03:28:19 INFO - Cleaning up... 03:28:19 INFO - Return code: 0 03:28:19 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:28:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:19 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 0x7fe4689c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1162410>, '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 0x1163310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11637a0>, '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': '33d5923976266a1c518c4bf7000001ab-1464172082.218159-1705217645', '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 03:28:19 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 03:28:19 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 03:28:19 INFO - Using env: {'DISPLAY': ':0', 03:28:19 INFO - 'HOME': '/home/cltbld', 03:28:19 INFO - 'LANG': 'en_US.UTF-8', 03:28:19 INFO - 'LANGUAGE': 'en_US:en', 03:28:19 INFO - 'LOGNAME': 'cltbld', 03:28:19 INFO - 'MAIL': '/var/mail/cltbld', 03:28:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:19 INFO - 'MOZ_NO_REMOTE': '1', 03:28:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:19 INFO - 'NO_EM_RESTART': '1', 03:28:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:19 INFO - 'PWD': '/builds/slave/test', 03:28:19 INFO - 'SHELL': '/bin/bash', 03:28:19 INFO - 'SHLVL': '1', 03:28:19 INFO - 'TERM': 'linux', 03:28:19 INFO - 'TMOUT': '86400', 03:28:19 INFO - 'USER': 'cltbld', 03:28:19 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464172082.218159-1705217645', 03:28:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:19 INFO - '_': '/tools/buildbot/bin/python'} 03:28:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:19 INFO - Downloading/unpacking psutil>=0.7.1 03:28:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:28:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:28:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:28:21 INFO - Installing collected packages: psutil 03:28:21 INFO - Running setup.py install for psutil 03:28:21 INFO - building 'psutil._psutil_linux' extension 03:28:21 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 03:28:21 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 03:28:21 INFO - building 'psutil._psutil_posix' extension 03:28:21 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 03:28:21 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 03:28:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:28:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:28:21 INFO - Successfully installed psutil 03:28:21 INFO - Cleaning up... 03:28:21 INFO - Return code: 0 03:28:21 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:28:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe4689c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1162410>, '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 0x1163310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11637a0>, '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': '33d5923976266a1c518c4bf7000001ab-1464172082.218159-1705217645', '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 03:28:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 03:28:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:28:21 INFO - Using env: {'DISPLAY': ':0', 03:28:21 INFO - 'HOME': '/home/cltbld', 03:28:21 INFO - 'LANG': 'en_US.UTF-8', 03:28:21 INFO - 'LANGUAGE': 'en_US:en', 03:28:21 INFO - 'LOGNAME': 'cltbld', 03:28:21 INFO - 'MAIL': '/var/mail/cltbld', 03:28:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:21 INFO - 'MOZ_NO_REMOTE': '1', 03:28:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:21 INFO - 'NO_EM_RESTART': '1', 03:28:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:21 INFO - 'PWD': '/builds/slave/test', 03:28:21 INFO - 'SHELL': '/bin/bash', 03:28:21 INFO - 'SHLVL': '1', 03:28:21 INFO - 'TERM': 'linux', 03:28:21 INFO - 'TMOUT': '86400', 03:28:21 INFO - 'USER': 'cltbld', 03:28:21 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464172082.218159-1705217645', 03:28:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:21 INFO - '_': '/tools/buildbot/bin/python'} 03:28:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:21 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:28:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:23 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:28:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:28:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:28:23 INFO - Installing collected packages: mozsystemmonitor 03:28:23 INFO - Running setup.py install for mozsystemmonitor 03:28:24 INFO - Successfully installed mozsystemmonitor 03:28:24 INFO - Cleaning up... 03:28:24 INFO - Return code: 0 03:28:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:28:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:24 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 0x7fe4689c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1162410>, '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 0x1163310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11637a0>, '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': '33d5923976266a1c518c4bf7000001ab-1464172082.218159-1705217645', '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 03:28:24 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 03:28:24 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 03:28:24 INFO - Using env: {'DISPLAY': ':0', 03:28:24 INFO - 'HOME': '/home/cltbld', 03:28:24 INFO - 'LANG': 'en_US.UTF-8', 03:28:24 INFO - 'LANGUAGE': 'en_US:en', 03:28:24 INFO - 'LOGNAME': 'cltbld', 03:28:24 INFO - 'MAIL': '/var/mail/cltbld', 03:28:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:24 INFO - 'MOZ_NO_REMOTE': '1', 03:28:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:24 INFO - 'NO_EM_RESTART': '1', 03:28:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:24 INFO - 'PWD': '/builds/slave/test', 03:28:24 INFO - 'SHELL': '/bin/bash', 03:28:24 INFO - 'SHLVL': '1', 03:28:24 INFO - 'TERM': 'linux', 03:28:24 INFO - 'TMOUT': '86400', 03:28:24 INFO - 'USER': 'cltbld', 03:28:24 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464172082.218159-1705217645', 03:28:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:24 INFO - '_': '/tools/buildbot/bin/python'} 03:28:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:24 INFO - Downloading/unpacking blobuploader==1.2.4 03:28:24 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 03:28:24 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 03:28:24 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 03:28:24 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 03:28:24 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 03:28:24 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 03:28:26 INFO - Downloading blobuploader-1.2.4.tar.gz 03:28:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:28:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:28:26 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 03:28:26 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 03:28:26 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 03:28:26 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 03:28:26 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 03:28:26 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 03:28:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:28:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:28:26 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 03:28:26 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 03:28:26 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 03:28:26 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 03:28:26 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 03:28:26 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 03:28:26 INFO - Downloading docopt-0.6.1.tar.gz 03:28:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:28:26 INFO - Installing collected packages: blobuploader, requests, docopt 03:28:26 INFO - Running setup.py install for blobuploader 03:28:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:28:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:28:27 INFO - Running setup.py install for requests 03:28:27 INFO - Running setup.py install for docopt 03:28:27 INFO - Successfully installed blobuploader requests docopt 03:28:27 INFO - Cleaning up... 03:28:27 INFO - Return code: 0 03:28:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:28: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')]} 03:28:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28: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')]} 03:28:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:27 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 0x7fe4689c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1162410>, '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 0x1163310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11637a0>, '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': '33d5923976266a1c518c4bf7000001ab-1464172082.218159-1705217645', '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 03:28:27 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 03:28:27 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 03:28:27 INFO - Using env: {'DISPLAY': ':0', 03:28:27 INFO - 'HOME': '/home/cltbld', 03:28:27 INFO - 'LANG': 'en_US.UTF-8', 03:28:27 INFO - 'LANGUAGE': 'en_US:en', 03:28:27 INFO - 'LOGNAME': 'cltbld', 03:28:27 INFO - 'MAIL': '/var/mail/cltbld', 03:28:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:27 INFO - 'MOZ_NO_REMOTE': '1', 03:28:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:27 INFO - 'NO_EM_RESTART': '1', 03:28:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:27 INFO - 'PWD': '/builds/slave/test', 03:28:27 INFO - 'SHELL': '/bin/bash', 03:28:27 INFO - 'SHLVL': '1', 03:28:27 INFO - 'TERM': 'linux', 03:28:27 INFO - 'TMOUT': '86400', 03:28:27 INFO - 'USER': 'cltbld', 03:28:27 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464172082.218159-1705217645', 03:28:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:27 INFO - '_': '/tools/buildbot/bin/python'} 03:28:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:28:27 INFO - Running setup.py (path:/tmp/pip-MJbXl9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:28:27 INFO - Running setup.py (path:/tmp/pip-WGPkM0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:28:27 INFO - Running setup.py (path:/tmp/pip-DJomc8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:28:27 INFO - Running setup.py (path:/tmp/pip-wwcg4f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:28:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:28:28 INFO - Running setup.py (path:/tmp/pip-aI7rkA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:28:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:28:28 INFO - Running setup.py (path:/tmp/pip-puVrSP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:28:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:28:28 INFO - Running setup.py (path:/tmp/pip-xKGLPc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:28:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:28:28 INFO - Running setup.py (path:/tmp/pip-UiB1UI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:28:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:28:28 INFO - Running setup.py (path:/tmp/pip-GVEv66-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:28:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:28:28 INFO - Running setup.py (path:/tmp/pip-6nlPGU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:28:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:28:28 INFO - Running setup.py (path:/tmp/pip-7hA49n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:28:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:28:28 INFO - Running setup.py (path:/tmp/pip-NSav3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:28:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:28:28 INFO - Running setup.py (path:/tmp/pip-K_fCaK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:28:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:28:28 INFO - Running setup.py (path:/tmp/pip-LsFzho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:28:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:28:28 INFO - Running setup.py (path:/tmp/pip-UZ0I_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:28:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:28:28 INFO - Running setup.py (path:/tmp/pip-YzAmOD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:28:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:28:28 INFO - Running setup.py (path:/tmp/pip-qpc55b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:28:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:28:28 INFO - Running setup.py install for manifestparser 03:28:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:28:29 INFO - Running setup.py install for mozcrash 03:28:29 INFO - Running setup.py install for mozdebug 03:28:29 INFO - Running setup.py install for mozdevice 03:28:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:28:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:28:29 INFO - Running setup.py install for mozfile 03:28:29 INFO - Running setup.py install for mozhttpd 03:28:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:28:29 INFO - Running setup.py install for mozinfo 03:28:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:28:29 INFO - Running setup.py install for mozInstall 03:28:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:28:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:28:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:28:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:28:29 INFO - Running setup.py install for mozleak 03:28:29 INFO - Running setup.py install for mozlog 03:28:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:28:30 INFO - Running setup.py install for moznetwork 03:28:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:28:30 INFO - Running setup.py install for mozprocess 03:28:30 INFO - Running setup.py install for mozprofile 03:28:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:28:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:28:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:28:30 INFO - Running setup.py install for mozrunner 03:28:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:28:30 INFO - Running setup.py install for mozscreenshot 03:28:30 INFO - Running setup.py install for moztest 03:28:30 INFO - Running setup.py install for mozversion 03:28:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:28:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:28:30 INFO - Cleaning up... 03:28:30 INFO - Return code: 0 03:28:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:28:30 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')]} 03:28:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:30 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')]} 03:28:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:30 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 0x7fe4689c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1162410>, '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 0x1163310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11637a0>, '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': '33d5923976266a1c518c4bf7000001ab-1464172082.218159-1705217645', '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 03:28:30 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 03:28:30 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 03:28:30 INFO - Using env: {'DISPLAY': ':0', 03:28:30 INFO - 'HOME': '/home/cltbld', 03:28:30 INFO - 'LANG': 'en_US.UTF-8', 03:28:30 INFO - 'LANGUAGE': 'en_US:en', 03:28:30 INFO - 'LOGNAME': 'cltbld', 03:28:30 INFO - 'MAIL': '/var/mail/cltbld', 03:28:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:30 INFO - 'MOZ_NO_REMOTE': '1', 03:28:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:30 INFO - 'NO_EM_RESTART': '1', 03:28:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:30 INFO - 'PWD': '/builds/slave/test', 03:28:30 INFO - 'SHELL': '/bin/bash', 03:28:30 INFO - 'SHLVL': '1', 03:28:30 INFO - 'TERM': 'linux', 03:28:30 INFO - 'TMOUT': '86400', 03:28:30 INFO - 'USER': 'cltbld', 03:28:30 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464172082.218159-1705217645', 03:28:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:30 INFO - '_': '/tools/buildbot/bin/python'} 03:28:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:28:30 INFO - Running setup.py (path:/tmp/pip-dC6NWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:28:31 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)) 03:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:28:31 INFO - Running setup.py (path:/tmp/pip-2tZAcM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:28:31 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)) 03:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:28:31 INFO - Running setup.py (path:/tmp/pip-0fQj0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:28:31 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)) 03:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:28:31 INFO - Running setup.py (path:/tmp/pip-z6HGuW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:28:31 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)) 03:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:28:31 INFO - Running setup.py (path:/tmp/pip-pM4u2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:28:31 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)) 03:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:28:31 INFO - Running setup.py (path:/tmp/pip-vaJHYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:28:31 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)) 03:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:28:31 INFO - Running setup.py (path:/tmp/pip-XL1aD1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:28:31 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)) 03:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:28:31 INFO - Running setup.py (path:/tmp/pip-vNJvv9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:28:31 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)) 03:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:28:31 INFO - Running setup.py (path:/tmp/pip-31tfxd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:28:31 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)) 03:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:28:31 INFO - Running setup.py (path:/tmp/pip-5T6wyR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:28:31 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)) 03:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:28:31 INFO - Running setup.py (path:/tmp/pip-3oJeum-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:28:31 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)) 03:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:28:31 INFO - Running setup.py (path:/tmp/pip-z81Gy8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:28:31 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)) 03:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:28:31 INFO - Running setup.py (path:/tmp/pip-PnLOJE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:28:31 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)) 03:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:28:31 INFO - Running setup.py (path:/tmp/pip-VhfPlM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:28:32 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)) 03:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:28:32 INFO - Running setup.py (path:/tmp/pip-9_It4y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:28:32 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)) 03:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:28:32 INFO - Running setup.py (path:/tmp/pip-paBfiT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:28:32 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)) 03:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:28:32 INFO - Running setup.py (path:/tmp/pip-tmjyFG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:28:32 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)) 03:28:32 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)) 03:28:32 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)) 03:28:32 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)) 03:28:32 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)) 03:28:32 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)) 03:28:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:28:32 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 03:28:32 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 03:28:32 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 03:28:32 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 03:28:32 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 03:28:32 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 03:28:34 INFO - Downloading blessings-1.6.tar.gz 03:28:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:28:34 INFO - Installing collected packages: blessings 03:28:34 INFO - Running setup.py install for blessings 03:28:34 INFO - Successfully installed blessings 03:28:34 INFO - Cleaning up... 03:28:34 INFO - Return code: 0 03:28:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:28:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:28:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:28:34 INFO - Reading from file tmpfile_stdout 03:28:34 INFO - Current package versions: 03:28:34 INFO - argparse == 1.2.1 03:28:34 INFO - blessings == 1.6 03:28:34 INFO - blobuploader == 1.2.4 03:28:34 INFO - docopt == 0.6.1 03:28:34 INFO - manifestparser == 1.1 03:28:34 INFO - mozInstall == 1.12 03:28:34 INFO - mozcrash == 0.17 03:28:34 INFO - mozdebug == 0.1 03:28:34 INFO - mozdevice == 0.48 03:28:34 INFO - mozfile == 1.2 03:28:34 INFO - mozhttpd == 0.7 03:28:34 INFO - mozinfo == 0.9 03:28:34 INFO - mozleak == 0.1 03:28:34 INFO - mozlog == 3.1 03:28:34 INFO - moznetwork == 0.27 03:28:34 INFO - mozprocess == 0.22 03:28:34 INFO - mozprofile == 0.28 03:28:34 INFO - mozrunner == 6.11 03:28:34 INFO - mozscreenshot == 0.1 03:28:34 INFO - mozsystemmonitor == 0.0 03:28:34 INFO - moztest == 0.7 03:28:34 INFO - mozversion == 1.4 03:28:34 INFO - psutil == 3.1.1 03:28:34 INFO - requests == 1.2.3 03:28:34 INFO - wsgiref == 0.1.2 03:28:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:28:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:34 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 0x7fe4689c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1162410>, '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 0x1163310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11637a0>, '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': '33d5923976266a1c518c4bf7000001ab-1464172082.218159-1705217645', '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 03:28:34 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 03:28:34 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 03:28:34 INFO - Using env: {'DISPLAY': ':0', 03:28:34 INFO - 'HOME': '/home/cltbld', 03:28:34 INFO - 'LANG': 'en_US.UTF-8', 03:28:34 INFO - 'LANGUAGE': 'en_US:en', 03:28:34 INFO - 'LOGNAME': 'cltbld', 03:28:34 INFO - 'MAIL': '/var/mail/cltbld', 03:28:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:34 INFO - 'MOZ_NO_REMOTE': '1', 03:28:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:34 INFO - 'NO_EM_RESTART': '1', 03:28:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:34 INFO - 'PWD': '/builds/slave/test', 03:28:34 INFO - 'SHELL': '/bin/bash', 03:28:34 INFO - 'SHLVL': '1', 03:28:34 INFO - 'TERM': 'linux', 03:28:34 INFO - 'TMOUT': '86400', 03:28:34 INFO - 'USER': 'cltbld', 03:28:34 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464172082.218159-1705217645', 03:28:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:34 INFO - '_': '/tools/buildbot/bin/python'} 03:28:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:34 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)) 03:28:34 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)) 03:28:34 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)) 03:28:34 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)) 03:28:34 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)) 03:28:34 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)) 03:28:34 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)) 03:28:34 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)) 03:28:35 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)) 03:28:35 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)) 03:28:35 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)) 03:28:35 INFO - Cleaning up... 03:28:35 INFO - Return code: 0 03:28:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:28:35 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')]} 03:28:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:35 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')]} 03:28:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:35 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 0x7fe4689c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1162410>, '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 0x1163310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11637a0>, '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': '33d5923976266a1c518c4bf7000001ab-1464172082.218159-1705217645', '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 03:28:35 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 03:28:35 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 03:28:35 INFO - Using env: {'DISPLAY': ':0', 03:28:35 INFO - 'HOME': '/home/cltbld', 03:28:35 INFO - 'LANG': 'en_US.UTF-8', 03:28:35 INFO - 'LANGUAGE': 'en_US:en', 03:28:35 INFO - 'LOGNAME': 'cltbld', 03:28:35 INFO - 'MAIL': '/var/mail/cltbld', 03:28:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:35 INFO - 'MOZ_NO_REMOTE': '1', 03:28:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:35 INFO - 'NO_EM_RESTART': '1', 03:28:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:35 INFO - 'PWD': '/builds/slave/test', 03:28:35 INFO - 'SHELL': '/bin/bash', 03:28:35 INFO - 'SHLVL': '1', 03:28:35 INFO - 'TERM': 'linux', 03:28:35 INFO - 'TMOUT': '86400', 03:28:35 INFO - 'USER': 'cltbld', 03:28:35 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464172082.218159-1705217645', 03:28:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:35 INFO - '_': '/tools/buildbot/bin/python'} 03:28:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:35 INFO - Downloading/unpacking jsonschema 03:28:35 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 03:28:35 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 03:28:35 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 03:28:35 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 03:28:35 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 03:28:35 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 03:28:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:28:37 INFO - Downloading/unpacking functools32 (from jsonschema) 03:28:37 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 03:28:37 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 03:28:37 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 03:28:37 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 03:28:37 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 03:28:37 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 03:28:37 INFO - Downloading functools32-3.2.3-2.tar.gz 03:28:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:28:37 INFO - warning: no files found matching '*.txt' 03:28:37 INFO - no previously-included directories found matching 'build' 03:28:37 INFO - no previously-included directories found matching 'dist' 03:28:37 INFO - no previously-included directories found matching '.git*' 03:28:37 INFO - Installing collected packages: jsonschema, functools32 03:28:37 INFO - Running setup.py install for functools32 03:28:37 INFO - warning: no files found matching '*.txt' 03:28:37 INFO - no previously-included directories found matching 'build' 03:28:37 INFO - no previously-included directories found matching 'dist' 03:28:37 INFO - no previously-included directories found matching '.git*' 03:28:37 INFO - Successfully installed jsonschema functools32 03:28:37 INFO - Cleaning up... 03:28:37 INFO - Return code: 0 03:28:37 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:28:37 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')]} 03:28:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:37 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')]} 03:28:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:37 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 0x7fe4689c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1162410>, '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 0x1163310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11637a0>, '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': '33d5923976266a1c518c4bf7000001ab-1464172082.218159-1705217645', '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 03:28:37 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 03:28:37 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 03:28:37 INFO - Using env: {'DISPLAY': ':0', 03:28:37 INFO - 'HOME': '/home/cltbld', 03:28:37 INFO - 'LANG': 'en_US.UTF-8', 03:28:37 INFO - 'LANGUAGE': 'en_US:en', 03:28:37 INFO - 'LOGNAME': 'cltbld', 03:28:37 INFO - 'MAIL': '/var/mail/cltbld', 03:28:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:37 INFO - 'MOZ_NO_REMOTE': '1', 03:28:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:37 INFO - 'NO_EM_RESTART': '1', 03:28:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:37 INFO - 'PWD': '/builds/slave/test', 03:28:37 INFO - 'SHELL': '/bin/bash', 03:28:37 INFO - 'SHLVL': '1', 03:28:37 INFO - 'TERM': 'linux', 03:28:37 INFO - 'TMOUT': '86400', 03:28:37 INFO - 'USER': 'cltbld', 03:28:37 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464172082.218159-1705217645', 03:28:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:37 INFO - '_': '/tools/buildbot/bin/python'} 03:28:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:37 INFO - Downloading/unpacking flake8 03:28:37 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 03:28:37 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 03:28:37 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 03:28:37 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 03:28:37 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 03:28:37 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 03:28:39 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:28:39 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:28:39 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 03:28:39 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 03:28:39 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 03:28:39 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 03:28:39 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 03:28:39 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 03:28:39 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:28:39 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:28:39 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 03:28:39 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 03:28:39 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 03:28:39 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 03:28:39 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 03:28:39 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 03:28:40 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:28:40 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 03:28:40 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 03:28:40 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 03:28:40 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 03:28:40 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 03:28:40 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 03:28:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:28:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:28:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:28:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:28:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:28:40 INFO - no previously-included directories found matching 'docs/_build' 03:28:40 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:28:40 INFO - Running setup.py install for pep8 03:28:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:28:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:28:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:28:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:28:40 INFO - no previously-included directories found matching 'docs/_build' 03:28:40 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:28:40 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:28:40 INFO - Cleaning up... 03:28:40 INFO - Return code: 0 03:28:40 INFO - Running post-action listener: _resource_record_post_action 03:28:40 INFO - Running post-action listener: _start_resource_monitoring 03:28:40 INFO - Starting resource monitoring. 03:28:40 INFO - ##### 03:28:40 INFO - ##### Running install step. 03:28:40 INFO - ##### 03:28:40 INFO - Running pre-action listener: _resource_record_pre_action 03:28:40 INFO - Running main action method: install 03:28:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:28:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:28:40 INFO - Reading from file tmpfile_stdout 03:28:40 INFO - Detecting whether we're running mozinstall >=1.0... 03:28:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:28:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:28:40 INFO - Reading from file tmpfile_stdout 03:28:40 INFO - Output received: 03:28:40 INFO - Usage: mozinstall [options] installer 03:28:40 INFO - Options: 03:28:40 INFO - -h, --help show this help message and exit 03:28:40 INFO - -d DEST, --destination=DEST 03:28:40 INFO - Directory to install application into. [default: 03:28:40 INFO - "/builds/slave/test"] 03:28:40 INFO - --app=APP Application being installed. [default: firefox] 03:28:40 INFO - mkdir: /builds/slave/test/build/application 03:28:40 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'] 03:28:40 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 03:28:56 INFO - Reading from file tmpfile_stdout 03:28:56 INFO - Output received: 03:28:56 INFO - /builds/slave/test/build/application/firefox/firefox 03:28:56 INFO - Running post-action listener: _resource_record_post_action 03:28:56 INFO - ##### 03:28:56 INFO - ##### Running run-tests step. 03:28:56 INFO - ##### 03:28:56 INFO - Running pre-action listener: _resource_record_pre_action 03:28:56 INFO - Running main action method: run_tests 03:28:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:28:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:28:56 INFO - Python 2.7.3 03:28:56 INFO - Return code: 0 03:28:56 INFO - grabbing minidump binary from tooltool 03:28:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:56 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 0x1162410>, '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 0x1163310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11637a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:28:56 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 03:28:56 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 03:28:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:28:56 INFO - Return code: 0 03:28:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:28:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:28:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:28:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:28:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:28:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:28:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:28:57 INFO - Return code: 0 03:28:57 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/Q9k4nuG4RIKO7ZNl-CLMvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 03:28:57 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/Q9k4nuG4RIKO7ZNl-CLMvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-063 --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 03:28:57 INFO - Using env: {'DISPLAY': ':0', 03:28:57 INFO - 'HOME': '/home/cltbld', 03:28:57 INFO - 'LANG': 'en_US.UTF-8', 03:28:57 INFO - 'LANGUAGE': 'en_US:en', 03:28:57 INFO - 'LOGNAME': 'cltbld', 03:28:57 INFO - 'MAIL': '/var/mail/cltbld', 03:28:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:28:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:28:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:57 INFO - 'MOZ_NO_REMOTE': '1', 03:28:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:28:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:57 INFO - 'NO_EM_RESTART': '1', 03:28:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:57 INFO - 'PWD': '/builds/slave/test', 03:28:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:28:57 INFO - 'SHELL': '/bin/bash', 03:28:57 INFO - 'SHLVL': '1', 03:28:57 INFO - 'TERM': 'linux', 03:28:57 INFO - 'TMOUT': '86400', 03:28:57 INFO - 'USER': 'cltbld', 03:28:57 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464172082.218159-1705217645', 03:28:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:57 INFO - '_': '/tools/buildbot/bin/python'} 03:28:57 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/Q9k4nuG4RIKO7ZNl-CLMvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 03:28:57 INFO - mozversion application_buildid: 20160525004047 03:28:57 INFO - mozversion application_changeset: 14079be66b19b1fa8c60fa34239bcff57ca51ab0 03:28:57 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:28:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:28:57 INFO - mozversion application_name: Firefox 03:28:57 INFO - mozversion application_remotingname: firefox-dev 03:28:57 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:28:57 INFO - mozversion application_vendor: Mozilla 03:28:57 INFO - mozversion application_version: 48.0a2 03:28:57 INFO - mozversion platform_buildid: 20160525004047 03:28:57 INFO - mozversion platform_changeset: 14079be66b19b1fa8c60fa34239bcff57ca51ab0 03:28:57 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:28:57 INFO - mozversion platform_version: 48.0a2 03:28:57 INFO - using testdate: 1464172137 03:28:57 INFO - actual date: 1464172137 03:28:57 INFO - starting webserver on 'localhost:42811' 03:28:57 INFO - SUITE-START | Running 2 tests 03:28:57 INFO - TEST-START | dromaeo_css 03:28:57 INFO - operating with platform_type : linux_ 03:28:57 INFO - Initialising browser for dromaeo_css test... 03:28:57 INFO - TEST-INFO | started process 19967 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIGGY7N/profile http://localhost:42811/getInfo.html) 03:29:10 INFO - PROCESS | 19967 | 03:29:10 INFO - PROCESS | 19967 | (process:20046): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:29:11 INFO - PROCESS | 19967 | __metrics Screen width/height:1600/1200 03:29:11 INFO - PROCESS | 19967 | colorDepth:24 03:29:11 INFO - PROCESS | 19967 | Browser inner width/height: 1024/697 03:29:11 INFO - PROCESS | 19967 | __metrics 03:29:13 ERROR - PROCESS | 19967 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 03:29:14 INFO - TEST-INFO | 19967: exit 0 03:29:14 INFO - Browser initialized. 03:29:14 INFO - Running cycle 1/1 for dromaeo_css test... 03:29:14 INFO - TEST-INFO | started process 20099 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIGGY7N/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:29:16 INFO - PROCESS | 20099 | 03:29:16 INFO - PROCESS | 20099 | (process:20170): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:29:26 INFO - PROCESS | 20099 | RSS: Main: 152125440 03:29:26 INFO - PROCESS | 20099 | 03:30:15 INFO - PROCESS | 20099 | 1464172215874 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] 03:32:23 INFO - PROCESS | 20099 | Cycle 1(1): loaded http://localhost:42811/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42811/tests/dromaeo/cssquery-ext.html) 03:32:24 INFO - PROCESS | 20099 | RSS: Main: 156348416 03:32:24 INFO - PROCESS | 20099 | 03:35:26 INFO - PROCESS | 20099 | Cycle 1(1): loaded http://localhost:42811/tests/dromaeo/cssquery-ext.html (next: http://localhost:42811/tests/dromaeo/cssquery-jquery.html) 03:35:27 INFO - PROCESS | 20099 | RSS: Main: 153632768 03:35:27 INFO - PROCESS | 20099 | 03:38:28 INFO - PROCESS | 20099 | Cycle 1(1): loaded http://localhost:42811/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42811/tests/dromaeo/cssquery-mootools.html) 03:38:29 INFO - PROCESS | 20099 | RSS: Main: 153247744 03:38:29 INFO - PROCESS | 20099 | 03:41:30 INFO - PROCESS | 20099 | Cycle 1(1): loaded http://localhost:42811/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42811/tests/dromaeo/cssquery-prototype.html) 03:41:31 INFO - PROCESS | 20099 | RSS: Main: 153038848 03:41:31 INFO - PROCESS | 20099 | 03:44:33 INFO - PROCESS | 20099 | Cycle 1(1): loaded http://localhost:42811/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42811/tests/dromaeo/cssquery-yui.html) 03:44:34 INFO - PROCESS | 20099 | RSS: Main: 154365952 03:44:34 INFO - PROCESS | 20099 | 03:47:36 INFO - PROCESS | 20099 | Cycle 1(1): loaded http://localhost:42811/tests/dromaeo/cssquery-yui.html (next: http://localhost:42811/tests/dromaeo/cssquery-dojo.html) 03:47:36 INFO - PROCESS | 20099 | RSS: Main: 155922432 03:47:36 INFO - PROCESS | 20099 | 03:47:36 INFO - PROCESS | 20099 | __start_tp_report 03:47:36 INFO - PROCESS | 20099 | _x_x_mozilla_page_load 03:47:36 INFO - PROCESS | 20099 | _x_x_mozilla_page_load_details 03:47:36 INFO - PROCESS | 20099 | |i|pagename|runs| 03:47:36 INFO - PROCESS | 20099 | |0;dojo.html;3386.3735208986336;3440.3119376124773;3449.9827500862525;3465.774724642898;3477.2176260341425;5835.0663893777;5835.6790376529325;5883.382244864292;5883.646981181132;5887.85280367991;5787.47912687858;5791.478766910977;5820.563457740665;5851.2100866383025;5883.499902508292;5282.603804714642;5309.389420216667;5365.490278423544;5368.00691872005;5432.754735003939;5247.160454327309;5352.91970620441;5488.368837583689;5492.313460817398;5517.337919449652;5202.8179013734525;5286.2070689396705;5294.258803767476;5324.201369794542;5402.702851343174;5312.893742125155;5355.143177091647;5356.892862142755;5370.087085195487;5375.301210842605;5051.924221136685;5207.244949482341;5248.685078895241;5278.709670968095;5324.467553244684;5534.723263836792;5613.242212301368;5652.85867853307;5675.233843431125;5684.687342196177;6101.938980610182;6139.140520327158;6176.258848938156;6187.84530386744;6195.2255968004;6161.353057928898;6239.625622462667;6242.937570624281;6244.500439964792;6265.592736472115;5797.507211886995;5813;5817.7382017809305;5838.474537291664;5857.76568937242;6280.968595157086;6314.842128946813;6319.58922670025;6329.461995730415;6340.144080549159;5996.940030599725;6072.666003369769;6123.050927106306;6128.417800308964;6137.5302083125;6200.968995154995;6207.6585787781205;6218.533609979269;6218.782342617987;6224.657643829632;6119.938800611937;6124.448799608057;6180.505559555225;6182;6209.844753881189;6123.83172914054;6125.785597504155;6171.382861713792;6187.597806142587;6195.132681424604;4653.395058642355;4657.767111644404;4681.789319480631;4686;4693.81224751013;4175.728577642443;4180.038591124058;4180.937285940713;4194.559571245037;4210.073783767628;5764.365919748824;5995.790147344822;6045.153678485016;6056.06131049688;6072.240969878765;6194.752209911643;6243.188385509855;6275.654838983808;6282.811515654537;6299.559030867796;5873.442023007808;5943.316518600416;5965.13505541694;5985.233961887728;6006.819795406145;5380.892382152335;5389.757460914268;5398.784048638089;5410.702411367334;5430.15832545956;6410.935890641127;6445.0332450132855;6460.386263305072;6462.967685161544;6465.418112369909;6125.754969801158;6137.070562331885;6214.627122372672;6220.937790622036;6247.5001999840815;6391.8721625566295;6485.416312531895;6488.351164883663;6490.48076153916;6496.610203387811;6071;6134.14122022926;6137.539684523589;6141.6007959482495;6142.969285153725;6174.166487524307;6220.875582488416;6247;6258.687065646791;6263.530235232467;6098.634081955097;6131.529590167291;6158;6171.938280617136;6184.134221209124;6082.464469141731;6119.339063573805;6122.154209354628;6136.477170546544;6144.477719393902;5921.496672782861;6001.279846418283;6038.396160384103;6057.697115144313;6084.361142080195;6151.354107818794;6185.649253843014;6206.255249370104;6220.098085777447;6221.47117495018;6048.879022419615;6079.270487541523;6091.769789042971;6100.389961003864;6120.632762034292 03:47:36 INFO - PROCESS | 20099 | |1;ext.html;664.1366223908917;670.3832474123807;673.9224989126252;718.5832217313958;733.4132693844923;38026.23947521048;38261.42607860884;38463.807680961625;38732.225355492876;38773.418398724;41623.58376416235;42412;42443;42443.78778106105;42464.57535424645;8836.734897953056;8983.14660107292;8994.055624159468;9010.819783604324;9029.819403611957;8742.30061595074;8847.823043539125;8884.200421962023;9066;9097.181253687168;9100.54497275137;9120.042395548471;9139.95430022849;9147.95426022869;9182.494962777044;9075.41009834362;9094.226990705798;9109.36234463591;9114.361994660376;9119.544022798833;9009.144131307581;9038.231750301233;9066.54667266634;9078.954605226998;9153.08469153086;42964.355534667004;43244.135117297796;43354.56645433568;43443.565564344266;43516;3610.656987586175;3635.6909662678704;3753.2681127180213;4101.85643502479;4368.868933931987;33154.834225828716;33921;33931.491027634605;34040.48939265913;34139.4879076814;4488.192125417424;4544.500104988481;4558.794854231567;4594.678372513926;4619.030003699228;320354;320407;320776;322594;323335;60616;60774.696126519084;61392.38607613956;61496;61605;64413.35586644167;69295;70366.296337037;70727.64636176787;70833;17178.31286748516;17332.30670773155;17340;17370.39203627867;17401.651966960842;13008.349582520836;13041.608751737273;13082.476700931857;13138.671533211746;13164.40760165795;19613.117409716597;19626.11682474292;19649;19650.115744791517;19826.1078251479;6602.900956485657;6734.629595372302;6814.761483348059;6865.485088618274;6921.342472465108;1036.6319956415364;1097.8133717268083;1102.399192440122;1126.0541145437708;1165.9708507287216;32614.836925815693;32889.83555082209;33122.50316245258;33188.83405582957;33302.666973330444;1258.3393718297966;1288.2463758701265;1289.1362786932777;1306.0139594606012;1312.5930961401996;16796.244169012425;16831.57921051959;17235.827641723423;17241.396551120903;17431.302747890197;494035;558300;605866;623459;623918;54614.72692636511;55311;55348.44651553433;55472;55531.444685552626;1493.9775903361458;1524.8170219573722;1525.0316049308547;1530.0360772713343;1623.0748473370302;30055.69944300529;30662.233444163183;30805.160804070078;31195.84402077975;31243.84378078095;53425;53545.73227133839;54046.189307159635;54077;54225;456361;457680;458390;460348;461032;30725;31104.68895311018;45919.77040114778;46806.53193468022;47076.29385559151;42410;43053.78473107614;43271.56728432675;43309.78345108254;43814.90462738457;40580.79709601433;41145.58854411417;41281.380779288935;41343.1731365365;42385;40404.3939340916;40631;40700.59299406968;40704.38943415792;41451.7927410361;40898.59101408948;41805;42086.78956605197;42506.57493425026;42649.78675106604;34891.30217395689;35505.467417988235;35960.100997475274;35996.82001589975;36014.27971440609;26975;27999.860000699868;28318.716812831608;28506.714932851235;28530.714692852805 03:47:36 INFO - PROCESS | 20099 | |2;jquery.html;402.8247712245173;403.4210907347956;408.07163702576617;408.14289991018865;414.68276768272267;14758.926205368985;18919;19503.12235949382;19530.31643892464;19534.31629892954;12059.2764434134;12436.067294952893;12509.249445033282;19740.60518789623;20116.195352185896;5272.182811664188;5380.515753582196;5385.030694474993;5392.299001129867;5419.756110975016;5160.045391602565;5306.522412982831;5362.624616276862;5368.62419630626;5375.6774593524515;5290.894182116355;5305.761240744176;5318.76065577048;5331.706756128431;5363.919541206866;5243.2659427680155;5410.134378499441;5459.590530710213;5475.863103422406;5509.917351239735;5374.48942350476;5378.085725426687;5380.811671591515;5391.838244852661;5396.325459317585;13147.145435546754;13616.251106189156;13640.86359136406;13647.249401282925;14159.71680566383;2369.8459600126107;2751.4497100579765;2761.502929472694;2780.207640822356;2782.2627003844;10050.346727462764;10243.641472548425;10420.531076101517;10767.461626918623;13441.39513721885;1958.3733205374285;1989.950251243716;2016.0625309231277;2035.2673037706413;2067.5658111796542;79083.20916790816;82201.58899205526;84309;85093.57453212756;85634.57182714046;10873.293235939638;10891.455427228608;10969.23215374916;11492.48283827213;11576.594819181457;14356.282185890665;15115.395384184729;15134.848651513565;15163.772543411636;15172.620684482976;8436.511229187281;8508.957455212809;8552.144785521523;8565.314774818;8630.654773809103;8416.284615807725;8495.235428811437;8517.44636598619;8561.957190214009;8587.441816281922;4650.883727906762;4772.451168115642;4775.403074615673;4805.27920811881;4850.684705494202;2010.2058139186543;2068.1520576563535;2076.678114892164;2091.790820917896;2134.914603415846;999.7950420163849;1064.031731124673;1087.3258579680491;1096.9743290023853;1111.0389513071298;17512.824871751374;18444.35444759454;19134.61730765377;19248.326308579133;19310.903445482683;1027.6505987963978;1088.1675518228562;1099.115212254127;1099.164634877483;1191.9106067045007;10825.566977320976;11240.49417776202;11242.156838237164;11266.324020558794;11377.658670239905;513673;561831;563302;573227;575656;58543;99306;100224;100240.49879750554;101223.49388253012;1155.9942200288945;1163.081165878963;1164.9650510484698;1167.258790667932;1183.1185766603935;17167.227474763415;17273.35903089255;17381.044042577272;17424.738628920324;17487.737683935007;29748;34748;36453.63546364503;38405.61594384132;40986.1802763949;43452.782736087385;44286.335704965095;50786.746066269436;56136;56502;8488.915110848813;8598.39811213209;8669.133086691281;8776.473411595325;8912.821743565222;9465.432074075577;12134.453949572115;12593.87406125927;12699.492020319083;13395;10949.726256843642;12098.395080245777;12135.089868260093;12207.511699532275;12317.507299707911;11742.236754610924;11916.08308133059;12056.156069075081;12080.51677932873;12272;12144.817827732768;12181.269123852242;12212.938935305621;12403.759624037524;12413;8493.235608795238;8627.43921645091;8730.694425695325;8730.781730456789;9111.544422778701;8577.185167409087;10801.459927003776;11386.658400248005;11535.192536522363;11794.938455539042 03:47:36 INFO - PROCESS | 20099 | |3;mootools.html;1487.286102670718;1513.7653663682129;1684.9157542122891;1806.8825526340786;1812.664657038449;7375.11498620165;8000.439969202158;8084.71703490378;8288.212619801125;8316.792080197998;7951.522908625487;8020.318272946806;8051.0338759348815;8068.1125076241715;8115.797105072376;2359.7050368703913;2366.2191476812695;2379.2862141357523;2382.332946774906;2389.8566086034807;2235.474663454087;2292.060255295329;2365.8462199957034;2369.4668699542635;2369.5971684813535;2362.515684284726;2382.380581048931;2391.6651668766385;2394.724606670229;2401.3636386357543;2341.3210169050953;2344.4842134730334;2353.14110349722;2356.3048900574286;2394.150076722773;2357.6934998450265;2379.654950032253;2381.523695260955;2381.9761802381927;2392.3301475586863;8098.878516822252;8112.472689275178;8117.918820811776;8127.634256458415;8147.388945829087;4992.650514463989;5107.923381149286;5150.665206761549;5151.227315902607;5154.304168937183;3341.482070279086;3349.581302337208;3397.643247459006;3531.52324436203;3564.536610240652;1119.7368618374676;1132.7111586545461;1155.589765633205;1163.4241050679968;1177.4701384377065;11613.30320180792;11613.535458581646;11621.07031437483;11628.767424651543;11674.182807203415;4297.419848320499;4418.76274643094;4431.0251744616135;4495.842645507457;4509.932351014738;9940.25448091396;9961.601535938626;9996.700098997042;9998.400095994119;10000.549975251131;5062.265971434122;5073.289739436482;5074.314967479417;5075.061113693979;5112.463191364927;4117.155983023473;4616.169089563844;4700.106979673851;4715.504871988461;4722.268048452426;4030.7984600769846;4047.9797601012397;4099.323611604052;4104.8152833121985;4121.258173528794;1290.4322098276728;1373.9587812365644;1375.4841934274648;1375.8417781955004;1380.813590165335;1022.2792930983638;1034.5448002878709;1039.6880935719255;1044.8746150461993;1077.353587847301;5788.3343415506915;5816.88366232673;5830.2420685310635;5965.343812180657;5967;446.3282759447076;451.45825009988147;451.6973627669469;453.1458201290591;471.3989663179405;3917.490726205632;3932.941005884914;3950.644442000234;3955.3869150281753;3990.960090399059;10023.799524009479;10351.223658225663;10372.429516376671;10384.11735002518;10413.01076397741;10228.181745460346;10237.078662920372;10242.180625549938;10246.6413675521;10278.691639250834;7685.193054729285;8003.359731221488;8041.3164880984605;8050.758477245692;8059.919400806034;5627.746751396279;5639.125935480007;5649;5692.203091567101;5726.055200891807;8996.370254082152;9006.504642244478;9063.13900179482;9081.500517471339;9204.355695101278;9017.008129105925;9074.183323500916;9261.212796912068;9315.208207302456;9348.298877584073;6736.461083113437;7266;7379.889301660372;7432.293932076444;7535.660895259617;7892.605369731606;7921.643526041457;7978.92021079805;7981.1619779924595;8003.7994300855335;7029.402500787286;7097.467689923174;7122.928770712227;7221.169565500035;7436.516626419266;7094.396976257076;7263.382612477787;7314.232005639331;7336.889946650911;7383.224761399975;6694.732210711517;6805.523613347216;6814.965925170342;6842.7605033823575;6857.2114206866845;4490.753008584559;4600.3329517219145;4630.4443466784205;4643.094596553639;4661.930071048869;4663.23056695655;4686.62506999446;4698.976505117453;4750.9287360690305;4759.976200119116 03:47:36 INFO - PROCESS | 20099 | |4;prototype.html;332.2739813507486;335.3410548272644;339.8648513963362;342.4230172159911;346.92020835207904;6604.768833090837;6691.799246022621;6705.765298214564;6710.765123220688;6712.899306510406;6552.213734351884;6560.409563139317;6576.704048317825;6577;6582.96708516458;4748.3827102476625;4877.122118018755;5015.799368025275;5027.069992051483;5027.4469808321055;4961.553460188582;4994.725290109042;5008.173651347523;5014.623903207255;5022.296878437021;4889.315495830587;4926.852194434173;4941.555260026596;4954.504549545035;4964.255361695738;4897.926531102036;4953.925691114636;4961.603071754251;4969.279454479117;4974.3533340665845;4316.56834316569;4323.1785960667685;4325.545817689161;4332.891677708051;4344.45694288214;6089.299730531001;6277.748890044393;6282.528810339197;6290.339514351019;6322.146510221107;5732.340780810218;5770.567207459415;5775.537956963432;5779.913301300484;5795.130730390433;6913.239543650195;6913.5506192097355;6932.306769323078;6935.196848819292;6936.20233673129;4700.858974230779;4731.266653668687;4736.928946065812;4739.0758802033615;4769.689970151963;7195.460340474433;7219.855602887913;7242.78271651846;7248.057752492195;7250.2024777274455;4793.856184314476;4883.096627123993;4885.5847252983185;4888.315635810989;4892.804287828518;4936.975315123402;4945.554900059012;4949.529794669501;4954.727489988085;4955.529224723646;5752.539796816244;5764.394738552475;5769.711514424262;5770.307563092456;5779.162021506942;6951.339622735832;6993.755218567326;7003.299670032956;7018;7020.859582808315;1729.135432283858;1748.3094177799699;1749.7900251969845;1754.9824501755074;1757.7539144519778;1145.3242586873785;1176.670532250971;1177.2171505948447;1178.2459226095307;1187.2520312203258;6712.463002959751;6715.026321183401;6718.49611279156;6726.091977583062;6738.528303018742;7126.465515086389;7221.061262036007;7226.349628533352;7251.854962900712;7256.8911466328045;6809.080774095433;6845.973104034435;6852.383285504229;6854.417374523221;6856.177258728984;3947.3684210526753;3964.9801750991637;3972.741771784825;3979.1444839359096;3983.2830090583393;7601.353884919844;7603.353714934293;7618.733344332922;7621.923780762232;7629.580373079423;7391.6673749681395;7458.2541745826065;7473;7527;7537.321641052222;7575.659095340723;7639.312461878347;7646.197149299243;7648.579328136894;7665.386769058462;7344.302291282534;7353.558786472829;7356.816079598053;7375.520591161558;7377.372923301365;7201.675924583511;7212.819679507845;7226.891596625949;7251.274872512707;7256.564606123438;7405.7778266652085;7606.353459955744;7639.121501027453;7653.158152603321;7654;4712.81148754046;4757.26262429324;4762.047590481849;4805.303231031551;4818.4217893852965;7301.269873012656;7334.6699398526125;7359.705611775469;7360.595167265637;7368.336849683555;7087.255838136922;7112.822179445555;7115.545136927959;7124.145102587722;7126.857462850818;6808.183018037867;6978.267281935324;6990.26602206761;7066.929330706627;7105.928940710527;6804.659767011531;6827.795166145023;6843.931560684329;6855.040294358893;6964.477664175106;7129.465290103367;7142.750003749844;7153.570785752871;7166.964165179141;7169.4981351304905;6905.413039891666;6919.75780847688;6922.480813939075;6926.896096558657;6954.165500140016 03:47:36 INFO - PROCESS | 20099 | |5;yui.html;819.0703551469085;851.8126012277297;865.8831057807195;872.1627237851662;912.5710915869547;13230.470781168753;13447.529336473226;13499.662508437294;13545.45818167272;13549.729005419886;12886.548970786025;12912.483500659962;12964.416601252966;13006.154599950996;13048.347582620878;743.2010588617231;883.1301168349171;896.5651658945407;907.5507623726264;907.8592818113203;887.4808237181256;896.2650626486284;901.9594118264694;902.2601466797229;903.286403741047;939.9718008459757;944.0417975754615;945.716285114463;948.5636607160715;950.2398081534744;927.9628814847398;937.1565590968183;938.5541867612898;939.4879790514152;940.4968341937031;689.6207086102623;690.3131384272681;691.5297597633607;692.6640579319027;695.3498478922173;14393.856061439355;14456.204908730017;14493.565193044225;14504.637384065378;14507.637309067251;13893.166410015432;14076.366563504667;14161.504347347793;14515.70968580633;14736.705265894729;11489.482973266224;11497.080233581293;11561.653150405416;11624.186306958516;11730.824037639357;3957.683385329167;4025.4565633639377;4100.159467309194;4103.425520427142;4128.731632443882;54207.45792542103;55107.17339239875;56007.71996140034;56182.71908640431;56937.430625693625;11051.115910727123;11167.553297868157;11337.773244535063;11468.024338755744;11516.309021458572;20127.698084528743;20164.89917550403;20178.29375971834;20197;20231.291904783557;8222.917770822334;8238.958805205935;8272.214139656722;8393.916060839314;8998.280137588978;4955.975220123948;4967.155583550805;5028.396592408862;5040.445550989388;5059.747012649353;3421.1447138215444;3439.1917899293644;3461.757676962639;3481.1819222482695;3481.8259087045544;597.9252593425822;658.4699317049821;664.9035889796049;665.2416245480157;671.9092922455503;627.6077451592755;696.916370035599;725.8966371115874;731.7073170731643;737.5021860244314;8647.654093836176;8832.91167088321;9217.308701847254;9241.260699144052;9510.476923769122;720.1861896057421;734.8309888725623;738.9445791565654;742.8848528478095;754.5962909843317;4130.607592278729;4207.158568286355;4230.746155230696;4325.437693099877;4350.912981740347;56602.43397566054;58020.41979580234;58084.419155807904;58087.4191258082;64180;46717.56183162594;46832.06335873264;52438.47561524336;53084;53118;47663.28505072427;47914.76042619834;50003.249951250764;50522.74738626283;51223;8903.421277616933;8909.465432074096;8936.642534298555;9039.367244292836;9357.812843742951;36966.07584810401;37272.81363593165;37274.627253727114;37712.057198570255;38314.6168538311;43819.342709860015;48216.5178348212;48521.27218091661;48652.27021594608;48780.26829597488;11873.525058997544;12161;12166.756664866476;13045.543405980745;13091;13033;13738.725225495235;14695.485658001919;14808.851911480748;15551.766723499382;12151.81772273399;12692.238465692088;12848.972082233586;12878.871211288142;12963.611091667264;13031.869681303066;13044.934775326443;13191.538296159588;13220.801687974496;13269.933650331686;12086.576969806014;12329.568465103679;12352.567660131852;12443.315617640754;12445.128840981044;10697.679069627924;10960.780784384428;11172.273802202832;11276.267042642203;11433.656990289972;10267.435291059064;10790.838137428102;10812.621558245424;10957.506912188812;10987.560497580007 03:47:36 INFO - PROCESS | 20099 | __end_tp_report 03:47:36 INFO - PROCESS | 20099 | __start_cc_report 03:47:36 INFO - PROCESS | 20099 | _x_x_mozilla_cycle_collect,339 03:47:36 INFO - PROCESS | 20099 | __end_cc_report 03:47:36 INFO - PROCESS | 20099 | __startTimestamp1464173256759__endTimestamp 03:47:36 INFO - PROCESS | 20099 | 03:47:36 INFO - PROCESS | 20099 | ------- Summary: start ------- 03:47:36 INFO - PROCESS | 20099 | Number of tests: 6 03:47:36 INFO - PROCESS | 20099 | 03:47:36 INFO - PROCESS | 20099 | [#0] dojo.html Cycles:165 Average:5790.56 Median:6072.67 stddev:653.36 (10.8%) stddev-sans-first:627.55 03:47:36 INFO - PROCESS | 20099 | Values: 3386.4 3440.3 3450.0 3465.8 3477.2 5835.1 5835.7 5883.4 5883.6 5887.9 5787.5 5791.5 5820.6 5851.2 5883.5 5282.6 5309.4 5365.5 5368.0 5432.8 5247.2 5352.9 5488.4 5492.3 5517.3 5202.8 5286.2 5294.3 5324.2 5402.7 5312.9 5355.1 5356.9 5370.1 5375.3 5051.9 5207.2 5248.7 5278.7 5324.5 5534.7 5613.2 5652.9 5675.2 5684.7 6101.9 6139.1 6176.3 6187.8 6195.2 6161.4 6239.6 6242.9 6244.5 6265.6 5797.5 5813.0 5817.7 5838.5 5857.8 6281.0 6314.8 6319.6 6329.5 6340.1 5996.9 6072.7 6123.1 6128.4 6137.5 6201.0 6207.7 6218.5 6218.8 6224.7 6119.9 6124.4 6180.5 6182.0 6209.8 6123.8 6125.8 6171.4 6187.6 6195.1 4653.4 4657.8 4681.8 4686.0 4693.8 4175.7 4180.0 4180.9 4194.6 4210.1 5764.4 5995.8 6045.2 6056.1 6072.2 6194.8 6243.2 6275.7 6282.8 6299.6 5873.4 5943.3 5965.1 5985.2 6006.8 5380.9 5389.8 5398.8 5410.7 5430.2 6410.9 6445.0 6460.4 6463.0 6465.4 6125.8 6137.1 6214.6 6220.9 6247.5 6391.9 6485.4 6488.4 6490.5 6496.6 6071.0 6134.1 6137.5 6141.6 6143.0 6174.2 6220.9 6247.0 6258.7 6263.5 6098.6 6131.5 6158.0 6171.9 6184.1 6082.5 6119.3 6122.2 6136.5 6144.5 5921.5 6001.3 6038.4 6057.7 6084.4 6151.4 6185.6 6206.3 6220.1 6221.5 6048.9 6079.3 6091.8 6100.4 6120.6 03:47:36 INFO - PROCESS | 20099 | 03:47:36 INFO - PROCESS | 20099 | [#1] ext.html Cycles:180 Average:61836.27 Median:42411.00 stddev:124121.11 (292.7%) stddev-sans-first:124384.32 03:47:36 INFO - PROCESS | 20099 | Values: 664.1 670.4 673.9 718.6 733.4 38026.2 38261.4 38463.8 38732.2 38773.4 41623.6 42412.0 42443.0 42443.8 42464.6 8836.7 8983.1 8994.1 9010.8 9029.8 8742.3 8847.8 8884.2 9066.0 9097.2 9100.5 9120.0 9140.0 9148.0 9182.5 9075.4 9094.2 9109.4 9114.4 9119.5 9009.1 9038.2 9066.5 9079.0 9153.1 42964.4 43244.1 43354.6 43443.6 43516.0 3610.7 3635.7 3753.3 4101.9 4368.9 33154.8 33921.0 33931.5 34040.5 34139.5 4488.2 4544.5 4558.8 4594.7 4619.0 320354.0 320407.0 320776.0 322594.0 323335.0 60616.0 60774.7 61392.4 61496.0 61605.0 64413.4 69295.0 70366.3 70727.6 70833.0 17178.3 17332.3 17340.0 17370.4 17401.7 13008.3 13041.6 13082.5 13138.7 13164.4 19613.1 19626.1 19649.0 19650.1 19826.1 6602.9 6734.6 6814.8 6865.5 6921.3 1036.6 1097.8 1102.4 1126.1 1166.0 32614.8 32889.8 33122.5 33188.8 33302.7 1258.3 1288.2 1289.1 1306.0 1312.6 16796.2 16831.6 17235.8 17241.4 17431.3 494035.0 558300.0 605866.0 623459.0 623918.0 54614.7 55311.0 55348.4 55472.0 55531.4 1494.0 1524.8 1525.0 1530.0 1623.1 30055.7 30662.2 30805.2 31195.8 31243.8 53425.0 53545.7 54046.2 54077.0 54225.0 456361.0 457680.0 458390.0 460348.0 461032.0 30725.0 31104.7 45919.8 46806.5 47076.3 42410.0 43053.8 43271.6 43309.8 43814.9 40580.8 41145.6 41281.4 41343.2 42385.0 40404.4 40631.0 40700.6 40704.4 41451.8 40898.6 41805.0 42086.8 42506.6 42649.8 34891.3 35505.5 35960.1 35996.8 36014.3 26975.0 27999.9 28318.7 28506.7 28530.7 03:47:36 INFO - PROCESS | 20099 | 03:47:36 INFO - PROCESS | 20099 | [#2] jquery.html Cycles:180 Average:30182.47 Median:2067.86 stddev:91741.89 (4436.6%) stddev-sans-first:91972.00 03:47:36 INFO - PROCESS | 20099 | Values: 402.8 403.4 408.1 408.1 414.7 14758.9 18919.0 19503.1 19530.3 19534.3 12059.3 12436.1 12509.2 19740.6 20116.2 5272.2 5380.5 5385.0 5392.3 5419.8 5160.0 5306.5 5362.6 5368.6 5375.7 5290.9 5305.8 5318.8 5331.7 5363.9 5243.3 5410.1 5459.6 5475.9 5509.9 5374.5 5378.1 5380.8 5391.8 5396.3 13147.1 13616.3 13640.9 13647.2 14159.7 2369.8 2751.4 2761.5 2780.2 2782.3 10050.3 10243.6 10420.5 10767.5 13441.4 1958.4 1990.0 2016.1 2035.3 2067.6 79083.2 82201.6 84309.0 85093.6 85634.6 10873.3 10891.5 10969.2 11492.5 11576.6 14356.3 15115.4 15134.8 15163.8 15172.6 8436.5 8509.0 8552.1 8565.3 8630.7 8416.3 8495.2 8517.4 8562.0 8587.4 4650.9 4772.5 4775.4 4805.3 4850.7 2010.2 2068.2 2076.7 2091.8 2134.9 999.8 1064.0 1087.3 1097.0 1111.0 17512.8 18444.4 19134.6 19248.3 19310.9 1027.7 1088.2 1099.1 1099.2 1191.9 10825.6 11240.5 11242.2 11266.3 11377.7 513673.0 561831.0 563302.0 573227.0 575656.0 58543.0 99306.0 100224.0 100240.5 101223.5 1156.0 1163.1 1165.0 1167.3 1183.1 17167.2 17273.4 17381.0 17424.7 17487.7 29748.0 34748.0 36453.6 38405.6 40986.2 43452.8 44286.3 50786.7 56136.0 56502.0 8488.9 8598.4 8669.1 8776.5 8912.8 9465.4 12134.5 12593.9 12699.5 13395.0 10949.7 12098.4 12135.1 12207.5 12317.5 11742.2 11916.1 12056.2 12080.5 12272.0 12144.8 12181.3 12212.9 12403.8 12413.0 8493.2 8627.4 8730.7 8730.8 9111.5 8577.2 10801.5 11386.7 11535.2 11794.9 03:47:36 INFO - PROCESS | 20099 | 03:47:36 INFO - PROCESS | 20099 | [#3] mootools.html Cycles:180 Average:5502.36 Median:4652.51 stddev:3038.91 (65.3%) stddev-sans-first:3032.45 03:47:36 INFO - PROCESS | 20099 | Values: 1487.3 1513.8 1684.9 1806.9 1812.7 7375.1 8000.4 8084.7 8288.2 8316.8 7951.5 8020.3 8051.0 8068.1 8115.8 2359.7 2366.2 2379.3 2382.3 2389.9 2235.5 2292.1 2365.8 2369.5 2369.6 2362.5 2382.4 2391.7 2394.7 2401.4 2341.3 2344.5 2353.1 2356.3 2394.2 2357.7 2379.7 2381.5 2382.0 2392.3 8098.9 8112.5 8117.9 8127.6 8147.4 4992.7 5107.9 5150.7 5151.2 5154.3 3341.5 3349.6 3397.6 3531.5 3564.5 1119.7 1132.7 1155.6 1163.4 1177.5 11613.3 11613.5 11621.1 11628.8 11674.2 4297.4 4418.8 4431.0 4495.8 4509.9 9940.3 9961.6 9996.7 9998.4 10000.5 5062.3 5073.3 5074.3 5075.1 5112.5 4117.2 4616.2 4700.1 4715.5 4722.3 4030.8 4048.0 4099.3 4104.8 4121.3 1290.4 1374.0 1375.5 1375.8 1380.8 1022.3 1034.5 1039.7 1044.9 1077.4 5788.3 5816.9 5830.2 5965.3 5967.0 446.3 451.5 451.7 453.1 471.4 3917.5 3932.9 3950.6 3955.4 3991.0 10023.8 10351.2 10372.4 10384.1 10413.0 10228.2 10237.1 10242.2 10246.6 10278.7 7685.2 8003.4 8041.3 8050.8 8059.9 5627.7 5639.1 5649.0 5692.2 5726.1 8996.4 9006.5 9063.1 9081.5 9204.4 9017.0 9074.2 9261.2 9315.2 9348.3 6736.5 7266.0 7379.9 7432.3 7535.7 7892.6 7921.6 7978.9 7981.2 8003.8 7029.4 7097.5 7122.9 7221.2 7436.5 7094.4 7263.4 7314.2 7336.9 7383.2 6694.7 6805.5 6815.0 6842.8 6857.2 4490.8 4600.3 4630.4 4643.1 4661.9 4663.2 4686.6 4699.0 4750.9 4760.0 03:47:36 INFO - PROCESS | 20099 | 03:47:36 INFO - PROCESS | 20099 | [#4] prototype.html Cycles:180 Average:5860.75 Median:6713.96 stddev:1807.15 (26.9%) stddev-sans-first:1763.93 03:47:36 INFO - PROCESS | 20099 | Values: 332.3 335.3 339.9 342.4 346.9 6604.8 6691.8 6705.8 6710.8 6712.9 6552.2 6560.4 6576.7 6577.0 6583.0 4748.4 4877.1 5015.8 5027.1 5027.4 4961.6 4994.7 5008.2 5014.6 5022.3 4889.3 4926.9 4941.6 4954.5 4964.3 4897.9 4953.9 4961.6 4969.3 4974.4 4316.6 4323.2 4325.5 4332.9 4344.5 6089.3 6277.7 6282.5 6290.3 6322.1 5732.3 5770.6 5775.5 5779.9 5795.1 6913.2 6913.6 6932.3 6935.2 6936.2 4700.9 4731.3 4736.9 4739.1 4769.7 7195.5 7219.9 7242.8 7248.1 7250.2 4793.9 4883.1 4885.6 4888.3 4892.8 4937.0 4945.6 4949.5 4954.7 4955.5 5752.5 5764.4 5769.7 5770.3 5779.2 6951.3 6993.8 7003.3 7018.0 7020.9 1729.1 1748.3 1749.8 1755.0 1757.8 1145.3 1176.7 1177.2 1178.2 1187.3 6712.5 6715.0 6718.5 6726.1 6738.5 7126.5 7221.1 7226.3 7251.9 7256.9 6809.1 6846.0 6852.4 6854.4 6856.2 3947.4 3965.0 3972.7 3979.1 3983.3 7601.4 7603.4 7618.7 7621.9 7629.6 7391.7 7458.3 7473.0 7527.0 7537.3 7575.7 7639.3 7646.2 7648.6 7665.4 7344.3 7353.6 7356.8 7375.5 7377.4 7201.7 7212.8 7226.9 7251.3 7256.6 7405.8 7606.4 7639.1 7653.2 7654.0 4712.8 4757.3 4762.0 4805.3 4818.4 7301.3 7334.7 7359.7 7360.6 7368.3 7087.3 7112.8 7115.5 7124.1 7126.9 6808.2 6978.3 6990.3 7066.9 7105.9 6804.7 6827.8 6843.9 6855.0 6964.5 7129.5 7142.8 7153.6 7167.0 7169.5 6905.4 6919.8 6922.5 6926.9 6954.2 03:47:36 INFO - PROCESS | 20099 | 03:47:36 INFO - PROCESS | 20099 | [#5] yui.html Cycles:180 Average:14873.46 Median:45268.45 stddev:16827.45 (37.2%) stddev-sans-first:16841.56 03:47:36 INFO - PROCESS | 20099 | Values: 819.1 851.8 865.9 872.2 912.6 13230.5 13447.5 13499.7 13545.5 13549.7 12886.5 12912.5 12964.4 13006.2 13048.3 743.2 883.1 896.6 907.6 907.9 887.5 896.3 902.0 902.3 903.3 940.0 944.0 945.7 948.6 950.2 928.0 937.2 938.6 939.5 940.5 689.6 690.3 691.5 692.7 695.3 14393.9 14456.2 14493.6 14504.6 14507.6 13893.2 14076.4 14161.5 14515.7 14736.7 11489.5 11497.1 11561.7 11624.2 11730.8 3957.7 4025.5 4100.2 4103.4 4128.7 54207.5 55107.2 56007.7 56182.7 56937.4 11051.1 11167.6 11337.8 11468.0 11516.3 20127.7 20164.9 20178.3 20197.0 20231.3 8222.9 8239.0 8272.2 8393.9 8998.3 4956.0 4967.2 5028.4 5040.4 5059.7 3421.1 3439.2 3461.8 3481.2 3481.8 597.9 658.5 664.9 665.2 671.9 627.6 696.9 725.9 731.7 737.5 8647.7 8832.9 9217.3 9241.3 9510.5 720.2 734.8 738.9 742.9 754.6 4130.6 4207.2 4230.7 4325.4 4350.9 56602.4 58020.4 58084.4 58087.4 64180.0 46717.6 46832.1 52438.5 53084.0 53118.0 47663.3 47914.8 50003.2 50522.7 51223.0 8903.4 8909.5 8936.6 9039.4 9357.8 36966.1 37272.8 37274.6 37712.1 38314.6 43819.3 48216.5 48521.3 48652.3 48780.3 11873.5 12161.0 12166.8 13045.5 13091.0 13033.0 13738.7 14695.5 14808.9 15551.8 12151.8 12692.2 12849.0 12878.9 12963.6 13031.9 13044.9 13191.5 13220.8 13269.9 12086.6 12329.6 12352.6 12443.3 12445.1 10697.7 10960.8 11172.3 11276.3 11433.7 10267.4 10790.8 10812.6 10957.5 10987.6 03:47:36 INFO - PROCESS | 20099 | -------- Summary: end -------- 03:47:36 INFO - PROCESS | 20099 | 03:47:37 INFO - TEST-INFO | 20099: exit 0 03:47:37 INFO - TEST-OK | dromaeo_css | took 1119846ms 03:47:37 INFO - TEST-START | kraken 03:47:37 INFO - operating with platform_type : linux_ 03:47:37 INFO - Initialising browser for kraken test... 03:47:37 INFO - TEST-INFO | started process 20346 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzd6LG6/profile http://localhost:42811/getInfo.html) 03:47:43 INFO - PROCESS | 20346 | 03:47:43 INFO - PROCESS | 20346 | (process:20422): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:47:44 INFO - PROCESS | 20346 | __metrics Screen width/height:1600/1200 03:47:44 INFO - PROCESS | 20346 | colorDepth:24 03:47:44 INFO - PROCESS | 20346 | Browser inner width/height: 1024/697 03:47:44 INFO - PROCESS | 20346 | __metrics 03:47:45 ERROR - PROCESS | 20346 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 03:47:46 INFO - TEST-INFO | 20346: exit 0 03:47:46 INFO - Browser initialized. 03:47:46 INFO - Running cycle 1/1 for kraken test... 03:47:46 INFO - TEST-INFO | started process 20475 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzd6LG6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:47:48 INFO - PROCESS | 20475 | 03:47:48 INFO - PROCESS | 20475 | (process:20546): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:47:58 INFO - PROCESS | 20475 | RSS: Main: 152088576 03:47:58 INFO - PROCESS | 20475 | 03:48:00 INFO - PROCESS | 20475 | Cycle 1(1): loaded http://localhost:42811/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42811/tests/kraken/driver.html?testName=audio-beat-detection) 03:48:01 INFO - PROCESS | 20475 | RSS: Main: 157360128 03:48:01 INFO - PROCESS | 20475 | 03:48:04 INFO - PROCESS | 20475 | Cycle 1(1): loaded http://localhost:42811/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42811/tests/kraken/driver.html?testName=audio-dft) 03:48:05 INFO - PROCESS | 20475 | RSS: Main: 157573120 03:48:05 INFO - PROCESS | 20475 | 03:48:07 INFO - PROCESS | 20475 | Cycle 1(1): loaded http://localhost:42811/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42811/tests/kraken/driver.html?testName=audio-fft) 03:48:08 INFO - PROCESS | 20475 | RSS: Main: 157372416 03:48:08 INFO - PROCESS | 20475 | 03:48:10 INFO - PROCESS | 20475 | Cycle 1(1): loaded http://localhost:42811/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42811/tests/kraken/driver.html?testName=audio-oscillator) 03:48:11 INFO - PROCESS | 20475 | RSS: Main: 157552640 03:48:11 INFO - PROCESS | 20475 | 03:48:13 INFO - PROCESS | 20475 | Cycle 1(1): loaded http://localhost:42811/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42811/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:48:14 INFO - PROCESS | 20475 | RSS: Main: 157544448 03:48:14 INFO - PROCESS | 20475 | 03:48:17 INFO - PROCESS | 20475 | Cycle 1(1): loaded http://localhost:42811/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42811/tests/kraken/driver.html?testName=imaging-darkroom) 03:48:17 INFO - PROCESS | 20475 | RSS: Main: 157769728 03:48:17 INFO - PROCESS | 20475 | 03:48:21 INFO - PROCESS | 20475 | Cycle 1(1): loaded http://localhost:42811/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42811/tests/kraken/driver.html?testName=imaging-desaturate) 03:48:21 INFO - PROCESS | 20475 | RSS: Main: 157671424 03:48:21 INFO - PROCESS | 20475 | 03:48:24 INFO - PROCESS | 20475 | Cycle 1(1): loaded http://localhost:42811/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42811/tests/kraken/driver.html?testName=json-parse-financial) 03:48:25 INFO - PROCESS | 20475 | RSS: Main: 157474816 03:48:25 INFO - PROCESS | 20475 | 03:48:26 INFO - PROCESS | 20475 | Cycle 1(1): loaded http://localhost:42811/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42811/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:48:27 INFO - PROCESS | 20475 | RSS: Main: 157454336 03:48:27 INFO - PROCESS | 20475 | 03:48:28 INFO - PROCESS | 20475 | Cycle 1(1): loaded http://localhost:42811/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42811/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:48:29 INFO - PROCESS | 20475 | RSS: Main: 157396992 03:48:29 INFO - PROCESS | 20475 | 03:48:31 INFO - PROCESS | 20475 | Cycle 1(1): loaded http://localhost:42811/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42811/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:48:32 INFO - PROCESS | 20475 | RSS: Main: 157859840 03:48:32 INFO - PROCESS | 20475 | 03:48:34 INFO - PROCESS | 20475 | Cycle 1(1): loaded http://localhost:42811/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42811/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:48:35 INFO - PROCESS | 20475 | RSS: Main: 158474240 03:48:35 INFO - PROCESS | 20475 | 03:48:37 INFO - PROCESS | 20475 | Cycle 1(1): loaded http://localhost:42811/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42811/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:48:38 INFO - PROCESS | 20475 | RSS: Main: 157978624 03:48:38 INFO - PROCESS | 20475 | 03:48:40 INFO - PROCESS | 20475 | Cycle 1(1): loaded http://localhost:42811/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42811/tests/kraken/driver.html?testName=ai-astar) 03:48:40 INFO - PROCESS | 20475 | RSS: Main: 159387648 03:48:40 INFO - PROCESS | 20475 | 03:48:40 INFO - PROCESS | 20475 | __start_tp_report 03:48:40 INFO - PROCESS | 20475 | _x_x_mozilla_page_load 03:48:40 INFO - PROCESS | 20475 | _x_x_mozilla_page_load_details 03:48:40 INFO - PROCESS | 20475 | |i|pagename|runs| 03:48:40 INFO - PROCESS | 20475 | |0;ai-astar;110;110;104;109;110;111;104;110;109;111 03:48:40 INFO - PROCESS | 20475 | |1;audio-beat-detection;160;130;156;183;128;162;156;129;181;125 03:48:40 INFO - PROCESS | 20475 | |2;audio-dft;167;163;162;163;161;163;163;163;162;162 03:48:40 INFO - PROCESS | 20475 | |3;audio-fft;75;76;78;171;74;75;74;78;175;77 03:48:40 INFO - PROCESS | 20475 | |4;audio-oscillator;92;93;154;93;92;93;142;93;93;140 03:48:40 INFO - PROCESS | 20475 | |5;imaging-gaussian-blur;117;117;117;117;118;117;117;117;117;117 03:48:40 INFO - PROCESS | 20475 | |6;imaging-darkroom;147;148;147;149;147;148;147;147;148;147 03:48:40 INFO - PROCESS | 20475 | |7;imaging-desaturate;95;96;96;97;95;95;97;95;95;95 03:48:40 INFO - PROCESS | 20475 | |8;json-parse-financial;57;58;56;56;59;62;62;75;55;57 03:48:40 INFO - PROCESS | 20475 | |9;json-stringify-tinderbox;58;58;57;57;58;57;57;57;58;57 03:48:40 INFO - PROCESS | 20475 | |10;stanford-crypto-aes;73;80;73;73;73;74;73;73;74;72 03:48:40 INFO - PROCESS | 20475 | |11;stanford-crypto-ccm;114;127;117;120;112;113;114;112;130;129 03:48:40 INFO - PROCESS | 20475 | |12;stanford-crypto-pbkdf2;159;161;166;158;162;157;157;159;159;158 03:48:40 INFO - PROCESS | 20475 | |13;stanford-crypto-sha256-iterative;67;68;70;67;66;66;67;68;67;67 03:48:40 INFO - PROCESS | 20475 | __end_tp_report 03:48:40 INFO - PROCESS | 20475 | __start_cc_report 03:48:40 INFO - PROCESS | 20475 | _x_x_mozilla_cycle_collect,837 03:48:40 INFO - PROCESS | 20475 | __end_cc_report 03:48:40 INFO - PROCESS | 20475 | __startTimestamp1464173320507__endTimestamp 03:48:40 INFO - PROCESS | 20475 | 03:48:40 INFO - PROCESS | 20475 | ------- Summary: start ------- 03:48:40 INFO - PROCESS | 20475 | Number of tests: 14 03:48:40 INFO - PROCESS | 20475 | 03:48:40 INFO - PROCESS | 20475 | [#0] ai-astar Cycles:10 Average:108.80 Median:110.00 stddev:2.62 (2.4%) stddev-sans-first:2.74 03:48:40 INFO - PROCESS | 20475 | Values: 110.0 110.0 104.0 109.0 110.0 111.0 104.0 110.0 109.0 111.0 03:48:40 INFO - PROCESS | 20475 | 03:48:40 INFO - PROCESS | 20475 | [#1] audio-beat-detection Cycles:10 Average:151.00 Median:158.00 stddev:21.87 (13.8%) stddev-sans-first:22.96 03:48:40 INFO - PROCESS | 20475 | Values: 160.0 130.0 156.0 183.0 128.0 162.0 156.0 129.0 181.0 125.0 03:48:40 INFO - PROCESS | 20475 | 03:48:40 INFO - PROCESS | 20475 | [#2] audio-dft Cycles:10 Average:162.90 Median:163.00 stddev:1.60 (1.0%) stddev-sans-first:0.73 03:48:40 INFO - PROCESS | 20475 | Values: 167.0 163.0 162.0 163.0 161.0 163.0 163.0 163.0 162.0 162.0 03:48:40 INFO - PROCESS | 20475 | 03:48:40 INFO - PROCESS | 20475 | [#3] audio-fft Cycles:10 Average:95.30 Median:75.50 stddev:40.99 (54.3%) stddev-sans-first:42.81 03:48:40 INFO - PROCESS | 20475 | Values: 75.0 76.0 78.0 171.0 74.0 75.0 74.0 78.0 175.0 77.0 03:48:40 INFO - PROCESS | 20475 | 03:48:40 INFO - PROCESS | 20475 | [#4] audio-oscillator Cycles:10 Average:108.50 Median:93.00 stddev:25.67 (27.6%) stddev-sans-first:26.52 03:48:40 INFO - PROCESS | 20475 | Values: 92.0 93.0 154.0 93.0 92.0 93.0 142.0 93.0 93.0 140.0 03:48:40 INFO - PROCESS | 20475 | 03:48:40 INFO - PROCESS | 20475 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 03:48:40 INFO - PROCESS | 20475 | Values: 117.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 03:48:40 INFO - PROCESS | 20475 | 03:48:40 INFO - PROCESS | 20475 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 03:48:40 INFO - PROCESS | 20475 | Values: 147.0 148.0 147.0 149.0 147.0 148.0 147.0 147.0 148.0 147.0 03:48:40 INFO - PROCESS | 20475 | 03:48:40 INFO - PROCESS | 20475 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:95.50 stddev:0.84 (0.9%) stddev-sans-first:0.87 03:48:40 INFO - PROCESS | 20475 | Values: 95.0 96.0 96.0 97.0 95.0 95.0 97.0 95.0 95.0 95.0 03:48:40 INFO - PROCESS | 20475 | 03:48:40 INFO - PROCESS | 20475 | [#8] json-parse-financial Cycles:10 Average:59.70 Median:58.50 stddev:5.89 (10.1%) stddev-sans-first:6.16 03:48:40 INFO - PROCESS | 20475 | Values: 57.0 58.0 56.0 56.0 59.0 62.0 62.0 75.0 55.0 57.0 03:48:40 INFO - PROCESS | 20475 | 03:48:40 INFO - PROCESS | 20475 | [#9] json-stringify-tinderbox Cycles:10 Average:57.40 Median:57.50 stddev:0.52 (0.9%) stddev-sans-first:0.50 03:48:40 INFO - PROCESS | 20475 | Values: 58.0 58.0 57.0 57.0 58.0 57.0 57.0 57.0 58.0 57.0 03:48:40 INFO - PROCESS | 20475 | 03:48:40 INFO - PROCESS | 20475 | [#10] stanford-crypto-aes Cycles:10 Average:73.80 Median:73.00 stddev:2.25 (3.1%) stddev-sans-first:2.37 03:48:40 INFO - PROCESS | 20475 | Values: 73.0 80.0 73.0 73.0 73.0 74.0 73.0 73.0 74.0 72.0 03:48:40 INFO - PROCESS | 20475 | 03:48:40 INFO - PROCESS | 20475 | [#11] stanford-crypto-ccm Cycles:10 Average:118.80 Median:118.50 stddev:7.25 (6.1%) stddev-sans-first:7.48 03:48:40 INFO - PROCESS | 20475 | Values: 114.0 127.0 117.0 120.0 112.0 113.0 114.0 112.0 130.0 129.0 03:48:40 INFO - PROCESS | 20475 | 03:48:40 INFO - PROCESS | 20475 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.60 Median:159.00 stddev:2.76 (1.7%) stddev-sans-first:2.92 03:48:40 INFO - PROCESS | 20475 | Values: 159.0 161.0 166.0 158.0 162.0 157.0 157.0 159.0 159.0 158.0 03:48:40 INFO - PROCESS | 20475 | 03:48:40 INFO - PROCESS | 20475 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.00 stddev:1.16 (1.7%) stddev-sans-first:1.22 03:48:40 INFO - PROCESS | 20475 | Values: 67.0 68.0 70.0 67.0 66.0 66.0 67.0 68.0 67.0 67.0 03:48:40 INFO - PROCESS | 20475 | -------- Summary: end -------- 03:48:40 INFO - PROCESS | 20475 | 03:48:41 INFO - TEST-INFO | 20475: exit 0 03:48:41 INFO - TEST-OK | kraken | took 63909ms 03:48:41 INFO - SUITE-END | took 1183s 03:48:41 INFO - Completed test suite (00:19:43) 03:48:41 INFO - javascript benchmark 03:48:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3386.3735208986336, 3440.3119376124773, 3449.9827500862525, 3465.774724642898, 3477.2176260341425, 5835.0663893777, 5835.6790376529325, 5883.382244864292, 5883.646981181132, 5887.85280367991, 5787.47912687858, 5791.478766910977, 5820.563457740665, 5851.2100866383025, 5883.499902508292, 5282.603804714642, 5309.389420216667, 5365.490278423544, 5368.00691872005, 5432.754735003939, 5247.160454327309, 5352.91970620441, 5488.368837583689, 5492.313460817398, 5517.337919449652, 5202.8179013734525, 5286.2070689396705, 5294.258803767476, 5324.201369794542, 5402.702851343174, 5312.893742125155, 5355.143177091647, 5356.892862142755, 5370.087085195487, 5375.301210842605, 5051.924221136685, 5207.244949482341, 5248.685078895241, 5278.709670968095, 5324.467553244684, 5534.723263836792, 5613.242212301368, 5652.85867853307, 5675.233843431125, 5684.687342196177, 6101.938980610182, 6139.140520327158, 6176.258848938156, 6187.84530386744, 6195.2255968004, 6161.353057928898, 6239.625622462667, 6242.937570624281, 6244.500439964792, 6265.592736472115, 5797.507211886995, 5813.0, 5817.7382017809305, 5838.474537291664, 5857.76568937242, 6280.968595157086, 6314.842128946813, 6319.58922670025, 6329.461995730415, 6340.144080549159, 5996.940030599725, 6072.666003369769, 6123.050927106306, 6128.417800308964, 6137.5302083125, 6200.968995154995, 6207.6585787781205, 6218.533609979269, 6218.782342617987, 6224.657643829632, 6119.938800611937, 6124.448799608057, 6180.505559555225, 6182.0, 6209.844753881189, 6123.83172914054, 6125.785597504155, 6171.382861713792, 6187.597806142587, 6195.132681424604, 4653.395058642355, 4657.767111644404, 4681.789319480631, 4686.0, 4693.81224751013, 4175.728577642443, 4180.038591124058, 4180.937285940713, 4194.559571245037, 4210.073783767628, 5764.365919748824, 5995.790147344822, 6045.153678485016, 6056.06131049688, 6072.240969878765, 6194.752209911643, 6243.188385509855, 6275.654838983808, 6282.811515654537, 6299.559030867796, 5873.442023007808, 5943.316518600416, 5965.13505541694, 5985.233961887728, 6006.819795406145, 5380.892382152335, 5389.757460914268, 5398.784048638089, 5410.702411367334, 5430.15832545956, 6410.935890641127, 6445.0332450132855, 6460.386263305072, 6462.967685161544, 6465.418112369909, 6125.754969801158, 6137.070562331885, 6214.627122372672, 6220.937790622036, 6247.5001999840815, 6391.8721625566295, 6485.416312531895, 6488.351164883663, 6490.48076153916, 6496.610203387811, 6071.0, 6134.14122022926, 6137.539684523589, 6141.6007959482495, 6142.969285153725, 6174.166487524307, 6220.875582488416, 6247.0, 6258.687065646791, 6263.530235232467, 6098.634081955097, 6131.529590167291, 6158.0, 6171.938280617136, 6184.134221209124, 6082.464469141731, 6119.339063573805, 6122.154209354628, 6136.477170546544, 6144.477719393902, 5921.496672782861, 6001.279846418283, 6038.396160384103, 6057.697115144313, 6084.361142080195, 6151.354107818794, 6185.649253843014, 6206.255249370104, 6220.098085777447, 6221.47117495018, 6048.879022419615, 6079.270487541523, 6091.769789042971, 6100.389961003864, 6120.632762034292], "value": 5746.82351198599, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [664.1366223908917, 670.3832474123807, 673.9224989126252, 718.5832217313958, 733.4132693844923, 38026.23947521048, 38261.42607860884, 38463.807680961625, 38732.225355492876, 38773.418398724, 41623.58376416235, 42412.0, 42443.0, 42443.78778106105, 42464.57535424645, 8836.734897953056, 8983.14660107292, 8994.055624159468, 9010.819783604324, 9029.819403611957, 8742.30061595074, 8847.823043539125, 8884.200421962023, 9066.0, 9097.181253687168, 9100.54497275137, 9120.042395548471, 9139.95430022849, 9147.95426022869, 9182.494962777044, 9075.41009834362, 9094.226990705798, 9109.36234463591, 9114.361994660376, 9119.544022798833, 9009.144131307581, 9038.231750301233, 9066.54667266634, 9078.954605226998, 9153.08469153086, 42964.355534667004, 43244.135117297796, 43354.56645433568, 43443.565564344266, 43516.0, 3610.656987586175, 3635.6909662678704, 3753.2681127180213, 4101.85643502479, 4368.868933931987, 33154.834225828716, 33921.0, 33931.491027634605, 34040.48939265913, 34139.4879076814, 4488.192125417424, 4544.500104988481, 4558.794854231567, 4594.678372513926, 4619.030003699228, 320354.0, 320407.0, 320776.0, 322594.0, 323335.0, 60616.0, 60774.696126519084, 61392.38607613956, 61496.0, 61605.0, 64413.35586644167, 69295.0, 70366.296337037, 70727.64636176787, 70833.0, 17178.31286748516, 17332.30670773155, 17340.0, 17370.39203627867, 17401.651966960842, 13008.349582520836, 13041.608751737273, 13082.476700931857, 13138.671533211746, 13164.40760165795, 19613.117409716597, 19626.11682474292, 19649.0, 19650.115744791517, 19826.1078251479, 6602.900956485657, 6734.629595372302, 6814.761483348059, 6865.485088618274, 6921.342472465108, 1036.6319956415364, 1097.8133717268083, 1102.399192440122, 1126.0541145437708, 1165.9708507287216, 32614.836925815693, 32889.83555082209, 33122.50316245258, 33188.83405582957, 33302.666973330444, 1258.3393718297966, 1288.2463758701265, 1289.1362786932777, 1306.0139594606012, 1312.5930961401996, 16796.244169012425, 16831.57921051959, 17235.827641723423, 17241.396551120903, 17431.302747890197, 494035.0, 558300.0, 605866.0, 623459.0, 623918.0, 54614.72692636511, 55311.0, 55348.44651553433, 55472.0, 55531.444685552626, 1493.9775903361458, 1524.8170219573722, 1525.0316049308547, 1530.0360772713343, 1623.0748473370302, 30055.69944300529, 30662.233444163183, 30805.160804070078, 31195.84402077975, 31243.84378078095, 53425.0, 53545.73227133839, 54046.189307159635, 54077.0, 54225.0, 456361.0, 457680.0, 458390.0, 460348.0, 461032.0, 30725.0, 31104.68895311018, 45919.77040114778, 46806.53193468022, 47076.29385559151, 42410.0, 43053.78473107614, 43271.56728432675, 43309.78345108254, 43814.90462738457, 40580.79709601433, 41145.58854411417, 41281.380779288935, 41343.1731365365, 42385.0, 40404.3939340916, 40631.0, 40700.59299406968, 40704.38943415792, 41451.7927410361, 40898.59101408948, 41805.0, 42086.78956605197, 42506.57493425026, 42649.78675106604, 34891.30217395689, 35505.467417988235, 35960.100997475274, 35996.82001589975, 36014.27971440609, 26975.0, 27999.860000699868, 28318.716812831608, 28506.714932851235, 28530.714692852805], "value": 20782.534837228824, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [402.8247712245173, 403.4210907347956, 408.07163702576617, 408.14289991018865, 414.68276768272267, 14758.926205368985, 18919.0, 19503.12235949382, 19530.31643892464, 19534.31629892954, 12059.2764434134, 12436.067294952893, 12509.249445033282, 19740.60518789623, 20116.195352185896, 5272.182811664188, 5380.515753582196, 5385.030694474993, 5392.299001129867, 5419.756110975016, 5160.045391602565, 5306.522412982831, 5362.624616276862, 5368.62419630626, 5375.6774593524515, 5290.894182116355, 5305.761240744176, 5318.76065577048, 5331.706756128431, 5363.919541206866, 5243.2659427680155, 5410.134378499441, 5459.590530710213, 5475.863103422406, 5509.917351239735, 5374.48942350476, 5378.085725426687, 5380.811671591515, 5391.838244852661, 5396.325459317585, 13147.145435546754, 13616.251106189156, 13640.86359136406, 13647.249401282925, 14159.71680566383, 2369.8459600126107, 2751.4497100579765, 2761.502929472694, 2780.207640822356, 2782.2627003844, 10050.346727462764, 10243.641472548425, 10420.531076101517, 10767.461626918623, 13441.39513721885, 1958.3733205374285, 1989.950251243716, 2016.0625309231277, 2035.2673037706413, 2067.5658111796542, 79083.20916790816, 82201.58899205526, 84309.0, 85093.57453212756, 85634.57182714046, 10873.293235939638, 10891.455427228608, 10969.23215374916, 11492.48283827213, 11576.594819181457, 14356.282185890665, 15115.395384184729, 15134.848651513565, 15163.772543411636, 15172.620684482976, 8436.511229187281, 8508.957455212809, 8552.144785521523, 8565.314774818, 8630.654773809103, 8416.284615807725, 8495.235428811437, 8517.44636598619, 8561.957190214009, 8587.441816281922, 4650.883727906762, 4772.451168115642, 4775.403074615673, 4805.27920811881, 4850.684705494202, 2010.2058139186543, 2068.1520576563535, 2076.678114892164, 2091.790820917896, 2134.914603415846, 999.7950420163849, 1064.031731124673, 1087.3258579680491, 1096.9743290023853, 1111.0389513071298, 17512.824871751374, 18444.35444759454, 19134.61730765377, 19248.326308579133, 19310.903445482683, 1027.6505987963978, 1088.1675518228562, 1099.115212254127, 1099.164634877483, 1191.9106067045007, 10825.566977320976, 11240.49417776202, 11242.156838237164, 11266.324020558794, 11377.658670239905, 513673.0, 561831.0, 563302.0, 573227.0, 575656.0, 58543.0, 99306.0, 100224.0, 100240.49879750554, 101223.49388253012, 1155.9942200288945, 1163.081165878963, 1164.9650510484698, 1167.258790667932, 1183.1185766603935, 17167.227474763415, 17273.35903089255, 17381.044042577272, 17424.738628920324, 17487.737683935007, 29748.0, 34748.0, 36453.63546364503, 38405.61594384132, 40986.1802763949, 43452.782736087385, 44286.335704965095, 50786.746066269436, 56136.0, 56502.0, 8488.915110848813, 8598.39811213209, 8669.133086691281, 8776.473411595325, 8912.821743565222, 9465.432074075577, 12134.453949572115, 12593.87406125927, 12699.492020319083, 13395.0, 10949.726256843642, 12098.395080245777, 12135.089868260093, 12207.511699532275, 12317.507299707911, 11742.236754610924, 11916.08308133059, 12056.156069075081, 12080.51677932873, 12272.0, 12144.817827732768, 12181.269123852242, 12212.938935305621, 12403.759624037524, 12413.0, 8493.235608795238, 8627.43921645091, 8730.694425695325, 8730.781730456789, 9111.544422778701, 8577.185167409087, 10801.459927003776, 11386.658400248005, 11535.192536522363, 11794.938455539042], "value": 9103.33092016042, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1487.286102670718, 1513.7653663682129, 1684.9157542122891, 1806.8825526340786, 1812.664657038449, 7375.11498620165, 8000.439969202158, 8084.71703490378, 8288.212619801125, 8316.792080197998, 7951.522908625487, 8020.318272946806, 8051.0338759348815, 8068.1125076241715, 8115.797105072376, 2359.7050368703913, 2366.2191476812695, 2379.2862141357523, 2382.332946774906, 2389.8566086034807, 2235.474663454087, 2292.060255295329, 2365.8462199957034, 2369.4668699542635, 2369.5971684813535, 2362.515684284726, 2382.380581048931, 2391.6651668766385, 2394.724606670229, 2401.3636386357543, 2341.3210169050953, 2344.4842134730334, 2353.14110349722, 2356.3048900574286, 2394.150076722773, 2357.6934998450265, 2379.654950032253, 2381.523695260955, 2381.9761802381927, 2392.3301475586863, 8098.878516822252, 8112.472689275178, 8117.918820811776, 8127.634256458415, 8147.388945829087, 4992.650514463989, 5107.923381149286, 5150.665206761549, 5151.227315902607, 5154.304168937183, 3341.482070279086, 3349.581302337208, 3397.643247459006, 3531.52324436203, 3564.536610240652, 1119.7368618374676, 1132.7111586545461, 1155.589765633205, 1163.4241050679968, 1177.4701384377065, 11613.30320180792, 11613.535458581646, 11621.07031437483, 11628.767424651543, 11674.182807203415, 4297.419848320499, 4418.76274643094, 4431.0251744616135, 4495.842645507457, 4509.932351014738, 9940.25448091396, 9961.601535938626, 9996.700098997042, 9998.400095994119, 10000.549975251131, 5062.265971434122, 5073.289739436482, 5074.314967479417, 5075.061113693979, 5112.463191364927, 4117.155983023473, 4616.169089563844, 4700.106979673851, 4715.504871988461, 4722.268048452426, 4030.7984600769846, 4047.9797601012397, 4099.323611604052, 4104.8152833121985, 4121.258173528794, 1290.4322098276728, 1373.9587812365644, 1375.4841934274648, 1375.8417781955004, 1380.813590165335, 1022.2792930983638, 1034.5448002878709, 1039.6880935719255, 1044.8746150461993, 1077.353587847301, 5788.3343415506915, 5816.88366232673, 5830.2420685310635, 5965.343812180657, 5967.0, 446.3282759447076, 451.45825009988147, 451.6973627669469, 453.1458201290591, 471.3989663179405, 3917.490726205632, 3932.941005884914, 3950.644442000234, 3955.3869150281753, 3990.960090399059, 10023.799524009479, 10351.223658225663, 10372.429516376671, 10384.11735002518, 10413.01076397741, 10228.181745460346, 10237.078662920372, 10242.180625549938, 10246.6413675521, 10278.691639250834, 7685.193054729285, 8003.359731221488, 8041.3164880984605, 8050.758477245692, 8059.919400806034, 5627.746751396279, 5639.125935480007, 5649.0, 5692.203091567101, 5726.055200891807, 8996.370254082152, 9006.504642244478, 9063.13900179482, 9081.500517471339, 9204.355695101278, 9017.008129105925, 9074.183323500916, 9261.212796912068, 9315.208207302456, 9348.298877584073, 6736.461083113437, 7266.0, 7379.889301660372, 7432.293932076444, 7535.660895259617, 7892.605369731606, 7921.643526041457, 7978.92021079805, 7981.1619779924595, 8003.7994300855335, 7029.402500787286, 7097.467689923174, 7122.928770712227, 7221.169565500035, 7436.516626419266, 7094.396976257076, 7263.382612477787, 7314.232005639331, 7336.889946650911, 7383.224761399975, 6694.732210711517, 6805.523613347216, 6814.965925170342, 6842.7605033823575, 6857.2114206866845, 4490.753008584559, 4600.3329517219145, 4630.4443466784205, 4643.094596553639, 4661.930071048869, 4663.23056695655, 4686.62506999446, 4698.976505117453, 4750.9287360690305, 4759.976200119116], "value": 4417.950085379023, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.2739813507486, 335.3410548272644, 339.8648513963362, 342.4230172159911, 346.92020835207904, 6604.768833090837, 6691.799246022621, 6705.765298214564, 6710.765123220688, 6712.899306510406, 6552.213734351884, 6560.409563139317, 6576.704048317825, 6577.0, 6582.96708516458, 4748.3827102476625, 4877.122118018755, 5015.799368025275, 5027.069992051483, 5027.4469808321055, 4961.553460188582, 4994.725290109042, 5008.173651347523, 5014.623903207255, 5022.296878437021, 4889.315495830587, 4926.852194434173, 4941.555260026596, 4954.504549545035, 4964.255361695738, 4897.926531102036, 4953.925691114636, 4961.603071754251, 4969.279454479117, 4974.3533340665845, 4316.56834316569, 4323.1785960667685, 4325.545817689161, 4332.891677708051, 4344.45694288214, 6089.299730531001, 6277.748890044393, 6282.528810339197, 6290.339514351019, 6322.146510221107, 5732.340780810218, 5770.567207459415, 5775.537956963432, 5779.913301300484, 5795.130730390433, 6913.239543650195, 6913.5506192097355, 6932.306769323078, 6935.196848819292, 6936.20233673129, 4700.858974230779, 4731.266653668687, 4736.928946065812, 4739.0758802033615, 4769.689970151963, 7195.460340474433, 7219.855602887913, 7242.78271651846, 7248.057752492195, 7250.2024777274455, 4793.856184314476, 4883.096627123993, 4885.5847252983185, 4888.315635810989, 4892.804287828518, 4936.975315123402, 4945.554900059012, 4949.529794669501, 4954.727489988085, 4955.529224723646, 5752.539796816244, 5764.394738552475, 5769.711514424262, 5770.307563092456, 5779.162021506942, 6951.339622735832, 6993.755218567326, 7003.299670032956, 7018.0, 7020.859582808315, 1729.135432283858, 1748.3094177799699, 1749.7900251969845, 1754.9824501755074, 1757.7539144519778, 1145.3242586873785, 1176.670532250971, 1177.2171505948447, 1178.2459226095307, 1187.2520312203258, 6712.463002959751, 6715.026321183401, 6718.49611279156, 6726.091977583062, 6738.528303018742, 7126.465515086389, 7221.061262036007, 7226.349628533352, 7251.854962900712, 7256.8911466328045, 6809.080774095433, 6845.973104034435, 6852.383285504229, 6854.417374523221, 6856.177258728984, 3947.3684210526753, 3964.9801750991637, 3972.741771784825, 3979.1444839359096, 3983.2830090583393, 7601.353884919844, 7603.353714934293, 7618.733344332922, 7621.923780762232, 7629.580373079423, 7391.6673749681395, 7458.2541745826065, 7473.0, 7527.0, 7537.321641052222, 7575.659095340723, 7639.312461878347, 7646.197149299243, 7648.579328136894, 7665.386769058462, 7344.302291282534, 7353.558786472829, 7356.816079598053, 7375.520591161558, 7377.372923301365, 7201.675924583511, 7212.819679507845, 7226.891596625949, 7251.274872512707, 7256.564606123438, 7405.7778266652085, 7606.353459955744, 7639.121501027453, 7653.158152603321, 7654.0, 4712.81148754046, 4757.26262429324, 4762.047590481849, 4805.303231031551, 4818.4217893852965, 7301.269873012656, 7334.6699398526125, 7359.705611775469, 7360.595167265637, 7368.336849683555, 7087.255838136922, 7112.822179445555, 7115.545136927959, 7124.145102587722, 7126.857462850818, 6808.183018037867, 6978.267281935324, 6990.26602206761, 7066.929330706627, 7105.928940710527, 6804.659767011531, 6827.795166145023, 6843.931560684329, 6855.040294358893, 6964.477664175106, 7129.465290103367, 7142.750003749844, 7153.570785752871, 7166.964165179141, 7169.4981351304905, 6905.413039891666, 6919.75780847688, 6922.480813939075, 6926.896096558657, 6954.165500140016], "value": 5261.682483290793, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [819.0703551469085, 851.8126012277297, 865.8831057807195, 872.1627237851662, 912.5710915869547, 13230.470781168753, 13447.529336473226, 13499.662508437294, 13545.45818167272, 13549.729005419886, 12886.548970786025, 12912.483500659962, 12964.416601252966, 13006.154599950996, 13048.347582620878, 743.2010588617231, 883.1301168349171, 896.5651658945407, 907.5507623726264, 907.8592818113203, 887.4808237181256, 896.2650626486284, 901.9594118264694, 902.2601466797229, 903.286403741047, 939.9718008459757, 944.0417975754615, 945.716285114463, 948.5636607160715, 950.2398081534744, 927.9628814847398, 937.1565590968183, 938.5541867612898, 939.4879790514152, 940.4968341937031, 689.6207086102623, 690.3131384272681, 691.5297597633607, 692.6640579319027, 695.3498478922173, 14393.856061439355, 14456.204908730017, 14493.565193044225, 14504.637384065378, 14507.637309067251, 13893.166410015432, 14076.366563504667, 14161.504347347793, 14515.70968580633, 14736.705265894729, 11489.482973266224, 11497.080233581293, 11561.653150405416, 11624.186306958516, 11730.824037639357, 3957.683385329167, 4025.4565633639377, 4100.159467309194, 4103.425520427142, 4128.731632443882, 54207.45792542103, 55107.17339239875, 56007.71996140034, 56182.71908640431, 56937.430625693625, 11051.115910727123, 11167.553297868157, 11337.773244535063, 11468.024338755744, 11516.309021458572, 20127.698084528743, 20164.89917550403, 20178.29375971834, 20197.0, 20231.291904783557, 8222.917770822334, 8238.958805205935, 8272.214139656722, 8393.916060839314, 8998.280137588978, 4955.975220123948, 4967.155583550805, 5028.396592408862, 5040.445550989388, 5059.747012649353, 3421.1447138215444, 3439.1917899293644, 3461.757676962639, 3481.1819222482695, 3481.8259087045544, 597.9252593425822, 658.4699317049821, 664.9035889796049, 665.2416245480157, 671.9092922455503, 627.6077451592755, 696.916370035599, 725.8966371115874, 731.7073170731643, 737.5021860244314, 8647.654093836176, 8832.91167088321, 9217.308701847254, 9241.260699144052, 9510.476923769122, 720.1861896057421, 734.8309888725623, 738.9445791565654, 742.8848528478095, 754.5962909843317, 4130.607592278729, 4207.158568286355, 4230.746155230696, 4325.437693099877, 4350.912981740347, 56602.43397566054, 58020.41979580234, 58084.419155807904, 58087.4191258082, 64180.0, 46717.56183162594, 46832.06335873264, 52438.47561524336, 53084.0, 53118.0, 47663.28505072427, 47914.76042619834, 50003.249951250764, 50522.74738626283, 51223.0, 8903.421277616933, 8909.465432074096, 8936.642534298555, 9039.367244292836, 9357.812843742951, 36966.07584810401, 37272.81363593165, 37274.627253727114, 37712.057198570255, 38314.6168538311, 43819.342709860015, 48216.5178348212, 48521.27218091661, 48652.27021594608, 48780.26829597488, 11873.525058997544, 12161.0, 12166.756664866476, 13045.543405980745, 13091.0, 13033.0, 13738.725225495235, 14695.485658001919, 14808.851911480748, 15551.766723499382, 12151.81772273399, 12692.238465692088, 12848.972082233586, 12878.871211288142, 12963.611091667264, 13031.869681303066, 13044.934775326443, 13191.538296159588, 13220.801687974496, 13269.933650331686, 12086.576969806014, 12329.568465103679, 12352.567660131852, 12443.315617640754, 12445.128840981044, 10697.679069627924, 10960.780784384428, 11172.273802202832, 11276.267042642203, 11433.656990289972, 10267.435291059064, 10790.838137428102, 10812.621558245424, 10957.506912188812, 10987.560497580007], "value": 6924.384211905603, "unit": "score"}], "name": "dromaeo_css", "value": 7479.090201413777, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 110.0, 104.0, 109.0, 110.0, 111.0, 104.0, 110.0, 109.0, 111.0], "value": 108.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 130.0, 156.0, 183.0, 128.0, 162.0, 156.0, 129.0, 181.0, 125.0], "value": 151.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 163.0, 162.0, 163.0, 161.0, 163.0, 163.0, 163.0, 162.0, 162.0], "value": 162.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 78.0, 171.0, 74.0, 75.0, 74.0, 78.0, 175.0, 77.0], "value": 95.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 154.0, 93.0, 92.0, 93.0, 142.0, 93.0, 93.0, 140.0], "value": 108.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 149.0, 147.0, 148.0, 147.0, 147.0, 148.0, 147.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 97.0, 95.0, 95.0, 97.0, 95.0, 95.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 56.0, 56.0, 59.0, 62.0, 62.0, 75.0, 55.0, 57.0], "value": 59.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 57.0, 57.0, 58.0, 57.0, 57.0, 57.0, 58.0, 57.0], "value": 57.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 80.0, 73.0, 73.0, 73.0, 74.0, 73.0, 73.0, 74.0, 72.0], "value": 73.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 127.0, 117.0, 120.0, 112.0, 113.0, 114.0, 112.0, 130.0, 129.0], "value": 118.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 161.0, 166.0, 158.0, 162.0, 157.0, 157.0, 159.0, 159.0, 158.0], "value": 159.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 70.0, 67.0, 66.0, 66.0, 67.0, 68.0, 67.0, 67.0], "value": 67.3, "unit": "score"}], "name": "kraken", "value": 1523.3, "alertThreshold": 2.0}]} 03:48:41 INFO - Return code: 0 03:48:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:48:41 ERROR - # TBPL SUCCESS # 03:48:41 INFO - Running post-action listener: _resource_record_post_action 03:48:41 INFO - Running post-run listener: _resource_record_post_run 03:48:42 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 0; Write bytes: 492838912; Read time: 0; Write time: 3488316 03:48:42 INFO - install - Wall time: 16s; CPU: 25.0%; Read bytes: 0; Write bytes: 160968704; Read time: 0; Write time: 1109016 03:48:42 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 331870208; Read time: 0; Write time: 2379300 03:48:42 INFO - Running post-run listener: _upload_blobber_files 03:48:42 INFO - Blob upload gear active. 03:48:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:48:42 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 03:48:42 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'] 03:48:42 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 03:48:43 INFO - (blobuploader) - INFO - Open directory for files ... 03:48:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:48:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:48:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:48:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:48:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:48:45 INFO - (blobuploader) - INFO - Done attempting. 03:48:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:48:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:48:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:48:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:48:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:48:46 INFO - (blobuploader) - INFO - Done attempting. 03:48:46 INFO - (blobuploader) - INFO - Iteration through files over. 03:48:46 INFO - Return code: 0 03:48:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:48:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:48:46 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d438b0bde6ec5af912c1ee0f37ce8baf0b9be8c498fa5743af1a077251a5403b390c42879111a1b353057b7cbff9f665eeb30b35edde2b55269ccfa45df52647", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/afce49f339100bd241d80f52e091e10ff5e5780a8b8c0b5d186cf6afcc8a459011e4888afc612ab97c1dca4dc1ecbb995984b773f34be91b23acad0dd984410c"} 03:48:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:48:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:48:46 INFO - Contents: 03:48:46 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d438b0bde6ec5af912c1ee0f37ce8baf0b9be8c498fa5743af1a077251a5403b390c42879111a1b353057b7cbff9f665eeb30b35edde2b55269ccfa45df52647", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/afce49f339100bd241d80f52e091e10ff5e5780a8b8c0b5d186cf6afcc8a459011e4888afc612ab97c1dca4dc1ecbb995984b773f34be91b23acad0dd984410c"} 03:48:46 INFO - Running post-run listener: copy_logs_to_upload_dir 03:48:46 INFO - Copying logs to upload dir... 03:48:46 INFO - mkdir: /builds/slave/test/build/upload/logs 03:48:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.572485 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-05-25 03:48:45.938106) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-25 03:48:45.942055) ========= 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=33d5923976266a1c518c4bf7000001ab-1464172082.218159-1705217645 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/d438b0bde6ec5af912c1ee0f37ce8baf0b9be8c498fa5743af1a077251a5403b390c42879111a1b353057b7cbff9f665eeb30b35edde2b55269ccfa45df52647", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/afce49f339100bd241d80f52e091e10ff5e5780a8b8c0b5d186cf6afcc8a459011e4888afc612ab97c1dca4dc1ecbb995984b773f34be91b23acad0dd984410c"} build_url:https://queue.taskcluster.net/v1/task/Q9k4nuG4RIKO7ZNl-CLMvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011415 build_url: 'https://queue.taskcluster.net/v1/task/Q9k4nuG4RIKO7ZNl-CLMvQ/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/d438b0bde6ec5af912c1ee0f37ce8baf0b9be8c498fa5743af1a077251a5403b390c42879111a1b353057b7cbff9f665eeb30b35edde2b55269ccfa45df52647", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/afce49f339100bd241d80f52e091e10ff5e5780a8b8c0b5d186cf6afcc8a459011e4888afc612ab97c1dca4dc1ecbb995984b773f34be91b23acad0dd984410c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-25 03:48:45.968739) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 03:48:45.969168) ========= 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=33d5923976266a1c518c4bf7000001ab-1464172082.218159-1705217645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004390 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 03:48:46.050938) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-25 03:48:46.051304) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-25 03:48:46.051656) ========= ========= Total master_lag: 0.16 =========