builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-061 starttime: 1460647273.77 results: success (0) buildid: 20160414073525 builduid: 354f8ba478354196ac567a043990194c revision: aef9d5c535ae78da48047a076c4a66bab551a2da ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 08:21:13.774332) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 08:21:13.775123) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 08:21:13.775612) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 08:21:13.869816) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 08:21:13.870528) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1460645738.372081-924134935 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-14 08:21:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 15.8M=0.001s 2016-04-14 08:21:15 (15.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.169926 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 08:21:14.059432) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 08:21:14.059800) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1460645738.372081-924134935 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020054 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 08:21:14.114549) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 08:21:14.115011) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev aef9d5c535ae78da48047a076c4a66bab551a2da --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev aef9d5c535ae78da48047a076c4a66bab551a2da --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=516f8d7ca085b4d087ab0a71000001a4-1460645738.372081-924134935 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-14 08:21:15,322 truncating revision to first 12 chars 2016-04-14 08:21:15,322 Setting DEBUG logging. 2016-04-14 08:21:15,323 attempt 1/10 2016-04-14 08:21:15,323 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/aef9d5c535ae?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-14 08:21:15,594 unpacking tar archive at: fx-team-aef9d5c535ae/testing/mozharness/ program finished with exit code 0 elapsedTime=0.569430 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 08:21:14.699118) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 08:21:14.699500) ========= script_repo_revision: aef9d5c535ae78da48047a076c4a66bab551a2da ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 08:21:14.699977) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 08:21:14.700319) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 08:21:14.709681) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-04-14 08:21:14.710149) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=516f8d7ca085b4d087ab0a71000001a4-1460645738.372081-924134935 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:21:16 INFO - MultiFileLogger online at 20160414 08:21:16 in /builds/slave/test 08:21:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 08:21:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:21:16 INFO - {'append_to_log': False, 08:21:16 INFO - 'base_work_dir': '/builds/slave/test', 08:21:16 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 08:21:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:21:16 INFO - 'branch': 'Fx-Team-Non-PGO', 08:21:16 INFO - 'buildbot_json_path': 'buildprops.json', 08:21:16 INFO - 'config_files': ('talos/linux_config.py',), 08:21:16 INFO - 'default_actions': ('clobber', 08:21:16 INFO - 'read-buildbot-config', 08:21:16 INFO - 'download-and-extract', 08:21:16 INFO - 'populate-webroot', 08:21:16 INFO - 'create-virtualenv', 08:21:16 INFO - 'install', 08:21:16 INFO - 'run-tests'), 08:21:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:21:16 INFO - 'download_minidump_stackwalk': True, 08:21:16 INFO - 'download_symbols': 'ondemand', 08:21:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:21:16 INFO - 'tooltool.py': '/tools/tooltool.py', 08:21:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:21:16 INFO - '/tools/misc-python/virtualenv.py')}, 08:21:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:21:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:21:16 INFO - 'installer_path': 'installer.exe', 08:21:16 INFO - 'log_level': 'info', 08:21:16 INFO - 'log_name': 'talos', 08:21:16 INFO - 'log_to_console': True, 08:21:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:21:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:21:16 INFO - 'opt_config_files': (), 08:21:16 INFO - 'pip_index': False, 08:21:16 INFO - 'sps_profile': False, 08:21:16 INFO - 'sps_profile_interval': 0, 08:21:16 INFO - 'suite': 'dromaeojs', 08:21:16 INFO - 'system_bits': '32', 08:21:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:21:16 INFO - 'title': 'talos-linux64-ix-061', 08:21:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:21:16 INFO - 'use_talos_json': True, 08:21:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:21:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:21:16 INFO - 'work_dir': 'build'} 08:21:16 INFO - ##### 08:21:16 INFO - ##### Running clobber step. 08:21:16 INFO - ##### 08:21:16 INFO - Running pre-action listener: _resource_record_pre_action 08:21:16 INFO - Running main action method: clobber 08:21:16 INFO - rmtree: /builds/slave/test/build 08:21:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:21:16 INFO - Running post-action listener: _resource_record_post_action 08:21:16 INFO - ##### 08:21:16 INFO - ##### Running read-buildbot-config step. 08:21:16 INFO - ##### 08:21:16 INFO - Running pre-action listener: _resource_record_pre_action 08:21:16 INFO - Running main action method: read_buildbot_config 08:21:16 INFO - Using buildbot properties: 08:21:16 INFO - { 08:21:16 INFO - "project": "", 08:21:16 INFO - "product": "firefox", 08:21:16 INFO - "script_repo_revision": "production", 08:21:16 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:21:16 INFO - "repository": "", 08:21:16 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 08:21:16 INFO - "buildid": "20160414073525", 08:21:16 INFO - "pgo_build": "False", 08:21:16 INFO - "basedir": "/builds/slave/test", 08:21:16 INFO - "buildnumber": 1645, 08:21:16 INFO - "slavename": "talos-linux64-ix-061", 08:21:16 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:21:16 INFO - "platform": "ubuntu64_hw", 08:21:16 INFO - "scheduler": "tests-fx-team-linux64-talos", 08:21:16 INFO - "branch": "fx-team", 08:21:16 INFO - "repo_path": "integration/fx-team", 08:21:16 INFO - "revision": "aef9d5c535ae78da48047a076c4a66bab551a2da", 08:21:16 INFO - "stage_platform": "linux64", 08:21:16 INFO - "builduid": "354f8ba478354196ac567a043990194c", 08:21:16 INFO - "slavebuilddir": "test" 08:21:16 INFO - } 08:21:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/dQ2Ijhe7Sl2k-9MiK2saew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 08:21:16 INFO - Running post-action listener: _resource_record_post_action 08:21:16 INFO - ##### 08:21:16 INFO - ##### Running download-and-extract step. 08:21:16 INFO - ##### 08:21:16 INFO - Running pre-action listener: _resource_record_pre_action 08:21:16 INFO - Running main action method: download_and_extract 08:21:16 INFO - mkdir: /builds/slave/test/build/tests 08:21:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:16 INFO - https://queue.taskcluster.net/v1/task/dQ2Ijhe7Sl2k-9MiK2saew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:21:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQ2Ijhe7Sl2k-9MiK2saew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:21:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQ2Ijhe7Sl2k-9MiK2saew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:21:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQ2Ijhe7Sl2k-9MiK2saew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:21:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQ2Ijhe7Sl2k-9MiK2saew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:21:20 INFO - Downloaded 1361 bytes. 08:21:20 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:21:20 INFO - Using the following test package requirements: 08:21:20 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 08:21:20 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:21:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:21:20 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:21:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:21:20 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:21:20 INFO - u'jsshell-linux-x86_64.zip'], 08:21:20 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:21:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:21:20 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 08:21:20 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:21:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:21:20 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:21:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:21:20 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:21:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:21:20 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:21:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:21:20 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:21:20 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')]} 08:21:20 INFO - https://queue.taskcluster.net/v1/task/dQ2Ijhe7Sl2k-9MiK2saew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:21:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQ2Ijhe7Sl2k-9MiK2saew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:21:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQ2Ijhe7Sl2k-9MiK2saew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:21:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQ2Ijhe7Sl2k-9MiK2saew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:21:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQ2Ijhe7Sl2k-9MiK2saew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:21:22 INFO - Downloaded 22202881 bytes. 08:21:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:21:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:21:23 INFO - Return code: 0 08:21:23 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:21:23 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')]} 08:21:23 INFO - https://queue.taskcluster.net/v1/task/dQ2Ijhe7Sl2k-9MiK2saew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:21:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQ2Ijhe7Sl2k-9MiK2saew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:21:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQ2Ijhe7Sl2k-9MiK2saew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:21:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQ2Ijhe7Sl2k-9MiK2saew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:21:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQ2Ijhe7Sl2k-9MiK2saew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:21:37 INFO - Downloaded 22202881 bytes. 08:21:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:21:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:21:38 INFO - Return code: 0 08:21:38 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')]} 08:21:38 INFO - https://queue.taskcluster.net/v1/task/dQ2Ijhe7Sl2k-9MiK2saew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:21:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQ2Ijhe7Sl2k-9MiK2saew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:21:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQ2Ijhe7Sl2k-9MiK2saew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:21:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQ2Ijhe7Sl2k-9MiK2saew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:21:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQ2Ijhe7Sl2k-9MiK2saew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:21:39 INFO - Downloaded 10841076 bytes. 08:21:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:21:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:21:39 INFO - Return code: 0 08:21:39 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')]} 08:21:39 INFO - https://queue.taskcluster.net/v1/task/dQ2Ijhe7Sl2k-9MiK2saew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:21:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQ2Ijhe7Sl2k-9MiK2saew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:21:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQ2Ijhe7Sl2k-9MiK2saew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:21:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQ2Ijhe7Sl2k-9MiK2saew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:21:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQ2Ijhe7Sl2k-9MiK2saew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:21:43 INFO - Downloaded 54446176 bytes. 08:21:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dQ2Ijhe7Sl2k-9MiK2saew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:21:43 INFO - mkdir: /builds/slave/test/properties 08:21:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:21:43 INFO - Writing to file /builds/slave/test/properties/build_url 08:21:43 INFO - Contents: 08:21:43 INFO - build_url:https://queue.taskcluster.net/v1/task/dQ2Ijhe7Sl2k-9MiK2saew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:21:44 INFO - Running post-action listener: _resource_record_post_action 08:21:44 INFO - Running post-action listener: set_extra_try_arguments 08:21:44 INFO - ##### 08:21:44 INFO - ##### Running populate-webroot step. 08:21:44 INFO - ##### 08:21:44 INFO - Running pre-action listener: _resource_record_pre_action 08:21:44 INFO - Running main action method: populate_webroot 08:21:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:21:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:21:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:21:44 INFO - '--tppagecycles', 08:21:44 INFO - '7'], 08:21:44 INFO - 'tests': ['tsvgm']}}, 08:21:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:21:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:21:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:21:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:21:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:21:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:21:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:44 INFO - 'talos_options': ['--disable-e10s'], 08:21:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:21:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:21:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:44 INFO - 'talos_options': ['--disable-e10s'], 08:21:44 INFO - 'tests': ['damp', 'tps']}, 08:21:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:44 INFO - 'tests': ['damp', 'tps']}, 08:21:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:21:44 INFO - 'tests': ['dromaeo_dom']}, 08:21:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:21:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:21:44 INFO - 'tests': ['a11yr', 08:21:44 INFO - 'ts_paint', 08:21:44 INFO - 'tpaint', 08:21:44 INFO - 'sessionrestore', 08:21:44 INFO - 'sessionrestore_no_auto_restore', 08:21:44 INFO - 'tabpaint']}, 08:21:44 INFO - 'other-e10s': {'tests': ['a11yr', 08:21:44 INFO - 'ts_paint', 08:21:44 INFO - 'tpaint', 08:21:44 INFO - 'sessionrestore', 08:21:44 INFO - 'sessionrestore_no_auto_restore', 08:21:44 INFO - 'tabpaint']}, 08:21:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:21:44 INFO - 'ts_paint', 08:21:44 INFO - 'tpaint', 08:21:44 INFO - 'sessionrestore', 08:21:44 INFO - 'sessionrestore_no_auto_restore', 08:21:44 INFO - 'tabpaint']}, 08:21:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:21:44 INFO - 'ts_paint', 08:21:44 INFO - 'tpaint', 08:21:44 INFO - 'sessionrestore', 08:21:44 INFO - 'sessionrestore_no_auto_restore', 08:21:44 INFO - 'tabpaint']}, 08:21:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:21:44 INFO - 'tests': ['a11yr', 08:21:44 INFO - 'ts_paint', 08:21:44 INFO - 'tpaint', 08:21:44 INFO - 'sessionrestore', 08:21:44 INFO - 'sessionrestore_no_auto_restore', 08:21:44 INFO - 'tabpaint']}, 08:21:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:21:44 INFO - 'tests': ['a11yr', 08:21:44 INFO - 'ts_paint', 08:21:44 INFO - 'tpaint', 08:21:44 INFO - 'sessionrestore', 08:21:44 INFO - 'sessionrestore_no_auto_restore', 08:21:44 INFO - 'tabpaint']}, 08:21:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:21:44 INFO - 'tests': ['tsvgx', 08:21:44 INFO - 'tsvgr_opacity', 08:21:44 INFO - 'tart', 08:21:44 INFO - 'tscrollx', 08:21:44 INFO - 'cart']}, 08:21:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:21:44 INFO - 'tsvgr_opacity', 08:21:44 INFO - 'tart', 08:21:44 INFO - 'tscrollx', 08:21:44 INFO - 'cart']}, 08:21:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:44 INFO - 'talos_options': ['--disable-e10s'], 08:21:44 INFO - 'tests': ['tp5o']}, 08:21:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:44 INFO - 'tests': ['tp5o']}, 08:21:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:44 INFO - 'talos_options': ['--disable-e10s', 08:21:44 INFO - '--xperf_path', 08:21:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:21:44 INFO - 'tests': ['tp5n']}, 08:21:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:44 INFO - 'talos_options': ['--xperf_path', 08:21:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:21:44 INFO - 'tests': ['tp5n']}}, 08:21:44 INFO - 'talos.zip': {'path': '', 08:21:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:21:44 INFO - Running post-action listener: _resource_record_post_action 08:21:44 INFO - ##### 08:21:44 INFO - ##### Running create-virtualenv step. 08:21:44 INFO - ##### 08:21:44 INFO - Running pre-action listener: _resource_record_pre_action 08:21:44 INFO - Running main action method: create_virtualenv 08:21:44 INFO - Creating virtualenv /builds/slave/test/build/venv 08:21:44 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 08:21:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:21:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:21:44 INFO - Using real prefix '/usr' 08:21:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:21:45 INFO - Installing distribute.............................................................................................................................................................................................done. 08:21:47 INFO - Installing pip.................done. 08:21:47 INFO - Return code: 0 08:21:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:21:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb04a4f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf855a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014410>, '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 0x1015310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10157a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1460645738.372081-924134935', '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 08:21:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:21:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:21:47 INFO - Using env: {'DISPLAY': ':0', 08:21:47 INFO - 'HOME': '/home/cltbld', 08:21:47 INFO - 'LANG': 'en_US.UTF-8', 08:21:47 INFO - 'LANGUAGE': 'en_US:en', 08:21:47 INFO - 'LOGNAME': 'cltbld', 08:21:47 INFO - 'MAIL': '/var/mail/cltbld', 08:21:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:47 INFO - 'MOZ_NO_REMOTE': '1', 08:21:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:47 INFO - 'NO_EM_RESTART': '1', 08:21:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:47 INFO - 'PWD': '/builds/slave/test', 08:21:47 INFO - 'SHELL': '/bin/bash', 08:21:47 INFO - 'SHLVL': '1', 08:21:47 INFO - 'TERM': 'linux', 08:21:47 INFO - 'TMOUT': '86400', 08:21:47 INFO - 'USER': 'cltbld', 08:21:47 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1460645738.372081-924134935', 08:21:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:47 INFO - '_': '/tools/buildbot/bin/python'} 08:21:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:47 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 08:21:47 INFO - Cleaning up... 08:21:47 INFO - Return code: 0 08:21:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:21:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb04a4f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf855a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014410>, '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 0x1015310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10157a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1460645738.372081-924134935', '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 08:21:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 08:21:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 08:21:47 INFO - Using env: {'DISPLAY': ':0', 08:21:47 INFO - 'HOME': '/home/cltbld', 08:21:47 INFO - 'LANG': 'en_US.UTF-8', 08:21:47 INFO - 'LANGUAGE': 'en_US:en', 08:21:47 INFO - 'LOGNAME': 'cltbld', 08:21:47 INFO - 'MAIL': '/var/mail/cltbld', 08:21:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:47 INFO - 'MOZ_NO_REMOTE': '1', 08:21:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:47 INFO - 'NO_EM_RESTART': '1', 08:21:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:47 INFO - 'PWD': '/builds/slave/test', 08:21:47 INFO - 'SHELL': '/bin/bash', 08:21:47 INFO - 'SHLVL': '1', 08:21:47 INFO - 'TERM': 'linux', 08:21:47 INFO - 'TMOUT': '86400', 08:21:47 INFO - 'USER': 'cltbld', 08:21:47 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1460645738.372081-924134935', 08:21:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:47 INFO - '_': '/tools/buildbot/bin/python'} 08:21:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:47 INFO - Downloading/unpacking psutil>=0.7.1 08:21:47 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 08:21:47 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 08:21:47 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 08:21:47 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 08:21:47 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 08:21:47 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 08:21:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:21:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:21:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:21:49 INFO - Installing collected packages: psutil 08:21:49 INFO - Running setup.py install for psutil 08:21:49 INFO - building 'psutil._psutil_linux' extension 08:21:49 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 08:21:49 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 08:21:49 INFO - building 'psutil._psutil_posix' extension 08:21:49 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 08:21:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:21:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:21:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:21:50 INFO - Successfully installed psutil 08:21:50 INFO - Cleaning up... 08:21:50 INFO - Return code: 0 08:21:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:21:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb04a4f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf855a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014410>, '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 0x1015310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10157a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1460645738.372081-924134935', '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 08:21:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 08:21:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 08:21:50 INFO - Using env: {'DISPLAY': ':0', 08:21:50 INFO - 'HOME': '/home/cltbld', 08:21:50 INFO - 'LANG': 'en_US.UTF-8', 08:21:50 INFO - 'LANGUAGE': 'en_US:en', 08:21:50 INFO - 'LOGNAME': 'cltbld', 08:21:50 INFO - 'MAIL': '/var/mail/cltbld', 08:21:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:50 INFO - 'MOZ_NO_REMOTE': '1', 08:21:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:50 INFO - 'NO_EM_RESTART': '1', 08:21:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:50 INFO - 'PWD': '/builds/slave/test', 08:21:50 INFO - 'SHELL': '/bin/bash', 08:21:50 INFO - 'SHLVL': '1', 08:21:50 INFO - 'TERM': 'linux', 08:21:50 INFO - 'TMOUT': '86400', 08:21:50 INFO - 'USER': 'cltbld', 08:21:50 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1460645738.372081-924134935', 08:21:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:50 INFO - '_': '/tools/buildbot/bin/python'} 08:21:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:21:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:21:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:21:52 INFO - Installing collected packages: mozsystemmonitor 08:21:52 INFO - Running setup.py install for mozsystemmonitor 08:21:52 INFO - Successfully installed mozsystemmonitor 08:21:52 INFO - Cleaning up... 08:21:52 INFO - Return code: 0 08:21:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:21:52 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')]} 08:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:52 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')]} 08:21:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:52 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 0x7fb04a4f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf855a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014410>, '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 0x1015310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10157a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1460645738.372081-924134935', '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 08:21:52 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 08:21:52 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 08:21:52 INFO - Using env: {'DISPLAY': ':0', 08:21:52 INFO - 'HOME': '/home/cltbld', 08:21:52 INFO - 'LANG': 'en_US.UTF-8', 08:21:52 INFO - 'LANGUAGE': 'en_US:en', 08:21:52 INFO - 'LOGNAME': 'cltbld', 08:21:52 INFO - 'MAIL': '/var/mail/cltbld', 08:21:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:52 INFO - 'MOZ_NO_REMOTE': '1', 08:21:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:52 INFO - 'NO_EM_RESTART': '1', 08:21:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:52 INFO - 'PWD': '/builds/slave/test', 08:21:52 INFO - 'SHELL': '/bin/bash', 08:21:52 INFO - 'SHLVL': '1', 08:21:52 INFO - 'TERM': 'linux', 08:21:52 INFO - 'TMOUT': '86400', 08:21:52 INFO - 'USER': 'cltbld', 08:21:52 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1460645738.372081-924134935', 08:21:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:52 INFO - '_': '/tools/buildbot/bin/python'} 08:21:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:52 INFO - Downloading/unpacking blobuploader==1.2.4 08:21:52 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 08:21:52 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 08:21:52 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 08:21:52 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 08:21:52 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 08:21:52 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 08:21:54 INFO - Downloading blobuploader-1.2.4.tar.gz 08:21:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:21:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:21:54 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 08:21:54 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 08:21:54 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 08:21:54 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 08:21:54 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 08:21:54 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 08:21:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:21:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:21:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:55 INFO - Downloading docopt-0.6.1.tar.gz 08:21:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:21:55 INFO - Installing collected packages: blobuploader, requests, docopt 08:21:55 INFO - Running setup.py install for blobuploader 08:21:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:21:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:21:55 INFO - Running setup.py install for requests 08:21:55 INFO - Running setup.py install for docopt 08:21:55 INFO - Successfully installed blobuploader requests docopt 08:21:55 INFO - Cleaning up... 08:21:56 INFO - Return code: 0 08:21:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:21: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')]} 08:21:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21: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')]} 08:21:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb04a4f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf855a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014410>, '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 0x1015310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10157a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1460645738.372081-924134935', '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 08:21:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:21:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:21:56 INFO - Using env: {'DISPLAY': ':0', 08:21:56 INFO - 'HOME': '/home/cltbld', 08:21:56 INFO - 'LANG': 'en_US.UTF-8', 08:21:56 INFO - 'LANGUAGE': 'en_US:en', 08:21:56 INFO - 'LOGNAME': 'cltbld', 08:21:56 INFO - 'MAIL': '/var/mail/cltbld', 08:21:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:56 INFO - 'MOZ_NO_REMOTE': '1', 08:21:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:56 INFO - 'NO_EM_RESTART': '1', 08:21:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:56 INFO - 'PWD': '/builds/slave/test', 08:21:56 INFO - 'SHELL': '/bin/bash', 08:21:56 INFO - 'SHLVL': '1', 08:21:56 INFO - 'TERM': 'linux', 08:21:56 INFO - 'TMOUT': '86400', 08:21:56 INFO - 'USER': 'cltbld', 08:21:56 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1460645738.372081-924134935', 08:21:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:56 INFO - '_': '/tools/buildbot/bin/python'} 08:21:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:21:56 INFO - Running setup.py (path:/tmp/pip-U5o8sJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:21:56 INFO - Running setup.py (path:/tmp/pip-ScGlxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:21:56 INFO - Running setup.py (path:/tmp/pip-oM36df-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:21:56 INFO - Running setup.py (path:/tmp/pip-4gMQKd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:21:56 INFO - Running setup.py (path:/tmp/pip-7CsiZh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:21:56 INFO - Running setup.py (path:/tmp/pip-RID2KI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:21:56 INFO - Running setup.py (path:/tmp/pip-jogL8B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:21:56 INFO - Running setup.py (path:/tmp/pip-A_aFnT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:21:56 INFO - Running setup.py (path:/tmp/pip-F87qhM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:21:56 INFO - Running setup.py (path:/tmp/pip-0t8nUi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:21:56 INFO - Running setup.py (path:/tmp/pip-vnoN9E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:21:57 INFO - Running setup.py (path:/tmp/pip-Z0zS6g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:21:57 INFO - Running setup.py (path:/tmp/pip-q74vrG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:21:57 INFO - Running setup.py (path:/tmp/pip-Jm_bR9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:21:57 INFO - Running setup.py (path:/tmp/pip-m6DKny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:21:57 INFO - Running setup.py (path:/tmp/pip-QCM5Sj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:21:57 INFO - Running setup.py (path:/tmp/pip-Z8Y_Aj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:21:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:21:57 INFO - Running setup.py install for manifestparser 08:21:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:21:57 INFO - Running setup.py install for mozcrash 08:21:57 INFO - Running setup.py install for mozdebug 08:21:57 INFO - Running setup.py install for mozdevice 08:21:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:21:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:21:57 INFO - Running setup.py install for mozfile 08:21:57 INFO - Running setup.py install for mozhttpd 08:21:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:21:58 INFO - Running setup.py install for mozinfo 08:21:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:21:58 INFO - Running setup.py install for mozInstall 08:21:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:21:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:21:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:21:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:21:58 INFO - Running setup.py install for mozleak 08:21:58 INFO - Running setup.py install for mozlog 08:21:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:21:58 INFO - Running setup.py install for moznetwork 08:21:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:21:58 INFO - Running setup.py install for mozprocess 08:21:58 INFO - Running setup.py install for mozprofile 08:21:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:21:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:21:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:21:58 INFO - Running setup.py install for mozrunner 08:21:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:21:58 INFO - Running setup.py install for mozscreenshot 08:21:59 INFO - Running setup.py install for moztest 08:21:59 INFO - Running setup.py install for mozversion 08:21:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:21:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:21:59 INFO - Cleaning up... 08:21:59 INFO - Return code: 0 08:21:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:21:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb04a4f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf855a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014410>, '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 0x1015310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10157a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1460645738.372081-924134935', '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 08:21:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:21:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:21:59 INFO - Using env: {'DISPLAY': ':0', 08:21:59 INFO - 'HOME': '/home/cltbld', 08:21:59 INFO - 'LANG': 'en_US.UTF-8', 08:21:59 INFO - 'LANGUAGE': 'en_US:en', 08:21:59 INFO - 'LOGNAME': 'cltbld', 08:21:59 INFO - 'MAIL': '/var/mail/cltbld', 08:21:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:59 INFO - 'MOZ_NO_REMOTE': '1', 08:21:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:59 INFO - 'NO_EM_RESTART': '1', 08:21:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:59 INFO - 'PWD': '/builds/slave/test', 08:21:59 INFO - 'SHELL': '/bin/bash', 08:21:59 INFO - 'SHLVL': '1', 08:21:59 INFO - 'TERM': 'linux', 08:21:59 INFO - 'TMOUT': '86400', 08:21:59 INFO - 'USER': 'cltbld', 08:21:59 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1460645738.372081-924134935', 08:21:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:59 INFO - '_': '/tools/buildbot/bin/python'} 08:21:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:21:59 INFO - Running setup.py (path:/tmp/pip-cc1CH9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:21:59 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)) 08:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:21:59 INFO - Running setup.py (path:/tmp/pip-0mEhJj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:21:59 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)) 08:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:21:59 INFO - Running setup.py (path:/tmp/pip-tqP8lM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:21:59 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)) 08:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:21:59 INFO - Running setup.py (path:/tmp/pip-dz40Ly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:21:59 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)) 08:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:21:59 INFO - Running setup.py (path:/tmp/pip-o8sqhb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:21:59 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)) 08:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:21:59 INFO - Running setup.py (path:/tmp/pip-jgXgDE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:21:59 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)) 08:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:21:59 INFO - Running setup.py (path:/tmp/pip-qsXTTn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:22:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:22:00 INFO - Running setup.py (path:/tmp/pip-en15ox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:22:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:22:00 INFO - Running setup.py (path:/tmp/pip-lE64G6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:22:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:22:00 INFO - Running setup.py (path:/tmp/pip-KnMEqt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:22:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:22:00 INFO - Running setup.py (path:/tmp/pip-gCB0Yv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:22:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:22:00 INFO - Running setup.py (path:/tmp/pip-tHzwgP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:22:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:22:00 INFO - Running setup.py (path:/tmp/pip-RRrHCN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:22:00 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)) 08:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:22:00 INFO - Running setup.py (path:/tmp/pip-Np9zbg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:22:00 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)) 08:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:22:00 INFO - Running setup.py (path:/tmp/pip-dDVFIK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:22:00 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)) 08:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:22:00 INFO - Running setup.py (path:/tmp/pip-SKd0pK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:22:00 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)) 08:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:22:00 INFO - Running setup.py (path:/tmp/pip-b642ap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:22:00 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)) 08:22:00 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)) 08:22:00 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)) 08:22:00 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)) 08:22:00 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)) 08:22:00 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)) 08:22:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:22:00 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 08:22:00 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 08:22:00 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 08:22:00 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 08:22:00 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 08:22:00 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 08:22:02 INFO - Downloading blessings-1.6.tar.gz 08:22:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:22:02 INFO - Installing collected packages: blessings 08:22:02 INFO - Running setup.py install for blessings 08:22:02 INFO - Successfully installed blessings 08:22:02 INFO - Cleaning up... 08:22:02 INFO - Return code: 0 08:22:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:22:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:22:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:22:03 INFO - Reading from file tmpfile_stdout 08:22:03 INFO - Current package versions: 08:22:03 INFO - argparse == 1.2.1 08:22:03 INFO - blessings == 1.6 08:22:03 INFO - blobuploader == 1.2.4 08:22:03 INFO - docopt == 0.6.1 08:22:03 INFO - manifestparser == 1.1 08:22:03 INFO - mozInstall == 1.12 08:22:03 INFO - mozcrash == 0.17 08:22:03 INFO - mozdebug == 0.1 08:22:03 INFO - mozdevice == 0.48 08:22:03 INFO - mozfile == 1.2 08:22:03 INFO - mozhttpd == 0.7 08:22:03 INFO - mozinfo == 0.9 08:22:03 INFO - mozleak == 0.1 08:22:03 INFO - mozlog == 3.1 08:22:03 INFO - moznetwork == 0.27 08:22:03 INFO - mozprocess == 0.22 08:22:03 INFO - mozprofile == 0.28 08:22:03 INFO - mozrunner == 6.11 08:22:03 INFO - mozscreenshot == 0.1 08:22:03 INFO - mozsystemmonitor == 0.0 08:22:03 INFO - moztest == 0.7 08:22:03 INFO - mozversion == 1.4 08:22:03 INFO - psutil == 3.1.1 08:22:03 INFO - requests == 1.2.3 08:22:03 INFO - wsgiref == 0.1.2 08:22:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:22:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:22:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:22:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb04a4f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf855a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014410>, '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 0x1015310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10157a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1460645738.372081-924134935', '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 08:22:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:22:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:22:03 INFO - Using env: {'DISPLAY': ':0', 08:22:03 INFO - 'HOME': '/home/cltbld', 08:22:03 INFO - 'LANG': 'en_US.UTF-8', 08:22:03 INFO - 'LANGUAGE': 'en_US:en', 08:22:03 INFO - 'LOGNAME': 'cltbld', 08:22:03 INFO - 'MAIL': '/var/mail/cltbld', 08:22:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:03 INFO - 'MOZ_NO_REMOTE': '1', 08:22:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:22:03 INFO - 'NO_EM_RESTART': '1', 08:22:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:22:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:03 INFO - 'PWD': '/builds/slave/test', 08:22:03 INFO - 'SHELL': '/bin/bash', 08:22:03 INFO - 'SHLVL': '1', 08:22:03 INFO - 'TERM': 'linux', 08:22:03 INFO - 'TMOUT': '86400', 08:22:03 INFO - 'USER': 'cltbld', 08:22:03 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1460645738.372081-924134935', 08:22:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:03 INFO - '_': '/tools/buildbot/bin/python'} 08:22:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:22:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:22:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:22:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:22:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:22:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:22:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:22:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:22:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:22:03 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:22:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:22:03 INFO - Cleaning up... 08:22:03 INFO - Return code: 0 08:22:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:22:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:22:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:22:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb04a4f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf855a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014410>, '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 0x1015310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10157a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1460645738.372081-924134935', '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 08:22:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:22:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:22:03 INFO - Using env: {'DISPLAY': ':0', 08:22:03 INFO - 'HOME': '/home/cltbld', 08:22:03 INFO - 'LANG': 'en_US.UTF-8', 08:22:03 INFO - 'LANGUAGE': 'en_US:en', 08:22:03 INFO - 'LOGNAME': 'cltbld', 08:22:03 INFO - 'MAIL': '/var/mail/cltbld', 08:22:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:03 INFO - 'MOZ_NO_REMOTE': '1', 08:22:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:22:03 INFO - 'NO_EM_RESTART': '1', 08:22:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:22:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:03 INFO - 'PWD': '/builds/slave/test', 08:22:03 INFO - 'SHELL': '/bin/bash', 08:22:03 INFO - 'SHLVL': '1', 08:22:03 INFO - 'TERM': 'linux', 08:22:03 INFO - 'TMOUT': '86400', 08:22:03 INFO - 'USER': 'cltbld', 08:22:03 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1460645738.372081-924134935', 08:22:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:03 INFO - '_': '/tools/buildbot/bin/python'} 08:22:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:03 INFO - Downloading/unpacking jsonschema 08:22:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:22:05 INFO - Downloading/unpacking functools32 (from jsonschema) 08:22:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:05 INFO - Downloading functools32-3.2.3-2.tar.gz 08:22:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:22:05 INFO - warning: no files found matching '*.txt' 08:22:05 INFO - no previously-included directories found matching 'build' 08:22:05 INFO - no previously-included directories found matching 'dist' 08:22:05 INFO - no previously-included directories found matching '.git*' 08:22:05 INFO - Installing collected packages: jsonschema, functools32 08:22:05 INFO - Running setup.py install for functools32 08:22:05 INFO - warning: no files found matching '*.txt' 08:22:05 INFO - no previously-included directories found matching 'build' 08:22:05 INFO - no previously-included directories found matching 'dist' 08:22:05 INFO - no previously-included directories found matching '.git*' 08:22:05 INFO - Successfully installed jsonschema functools32 08:22:05 INFO - Cleaning up... 08:22:05 INFO - Return code: 0 08:22:05 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:22: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')]} 08:22:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22: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')]} 08:22:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb04a4f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf855a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014410>, '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 0x1015310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10157a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1460645738.372081-924134935', '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 08:22:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 08:22:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:22:05 INFO - Using env: {'DISPLAY': ':0', 08:22:05 INFO - 'HOME': '/home/cltbld', 08:22:05 INFO - 'LANG': 'en_US.UTF-8', 08:22:05 INFO - 'LANGUAGE': 'en_US:en', 08:22:05 INFO - 'LOGNAME': 'cltbld', 08:22:05 INFO - 'MAIL': '/var/mail/cltbld', 08:22:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:05 INFO - 'MOZ_NO_REMOTE': '1', 08:22:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:22:05 INFO - 'NO_EM_RESTART': '1', 08:22:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:22:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:05 INFO - 'PWD': '/builds/slave/test', 08:22:05 INFO - 'SHELL': '/bin/bash', 08:22:05 INFO - 'SHLVL': '1', 08:22:05 INFO - 'TERM': 'linux', 08:22:05 INFO - 'TMOUT': '86400', 08:22:05 INFO - 'USER': 'cltbld', 08:22:05 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1460645738.372081-924134935', 08:22:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:05 INFO - '_': '/tools/buildbot/bin/python'} 08:22:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:06 INFO - Downloading/unpacking flake8 08:22:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:22:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:22:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:22:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:22:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:22:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:22:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:22:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:22:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:22:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:22:08 INFO - no previously-included directories found matching 'docs/_build' 08:22:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:22:08 INFO - Running setup.py install for pep8 08:22:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:22:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:22:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:22:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:22:08 INFO - no previously-included directories found matching 'docs/_build' 08:22:08 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:22:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:22:08 INFO - Cleaning up... 08:22:08 INFO - Return code: 0 08:22:08 INFO - Running post-action listener: _resource_record_post_action 08:22:08 INFO - Running post-action listener: _start_resource_monitoring 08:22:09 INFO - Starting resource monitoring. 08:22:09 INFO - ##### 08:22:09 INFO - ##### Running install step. 08:22:09 INFO - ##### 08:22:09 INFO - Running pre-action listener: _resource_record_pre_action 08:22:09 INFO - Running main action method: install 08:22:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:22:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:22:09 INFO - Reading from file tmpfile_stdout 08:22:09 INFO - Detecting whether we're running mozinstall >=1.0... 08:22:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:22:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:22:09 INFO - Reading from file tmpfile_stdout 08:22:09 INFO - Output received: 08:22:09 INFO - Usage: mozinstall [options] installer 08:22:09 INFO - Options: 08:22:09 INFO - -h, --help show this help message and exit 08:22:09 INFO - -d DEST, --destination=DEST 08:22:09 INFO - Directory to install application into. [default: 08:22:09 INFO - "/builds/slave/test"] 08:22:09 INFO - --app=APP Application being installed. [default: firefox] 08:22:09 INFO - mkdir: /builds/slave/test/build/application 08:22:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:22:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:22:24 INFO - Reading from file tmpfile_stdout 08:22:24 INFO - Output received: 08:22:24 INFO - /builds/slave/test/build/application/firefox/firefox 08:22:24 INFO - Running post-action listener: _resource_record_post_action 08:22:24 INFO - ##### 08:22:24 INFO - ##### Running run-tests step. 08:22:24 INFO - ##### 08:22:24 INFO - Running pre-action listener: _resource_record_pre_action 08:22:24 INFO - Running main action method: run_tests 08:22:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:22:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:22:24 INFO - Python 2.7.3 08:22:24 INFO - Return code: 0 08:22:24 INFO - grabbing minidump binary from tooltool 08:22: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')]} 08:22:24 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 0x1014410>, '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 0x1015310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10157a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:22:24 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 08:22:24 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 08:22:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:22:25 INFO - Return code: 0 08:22:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:22:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:22:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:22:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:22:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:22:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:22:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:22:26 INFO - Return code: 0 08:22:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dQ2Ijhe7Sl2k-9MiK2saew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:22:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dQ2Ijhe7Sl2k-9MiK2saew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:22:26 INFO - Using env: {'DISPLAY': ':0', 08:22:26 INFO - 'HOME': '/home/cltbld', 08:22:26 INFO - 'LANG': 'en_US.UTF-8', 08:22:26 INFO - 'LANGUAGE': 'en_US:en', 08:22:26 INFO - 'LOGNAME': 'cltbld', 08:22:26 INFO - 'MAIL': '/var/mail/cltbld', 08:22:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:22:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:22:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:26 INFO - 'MOZ_NO_REMOTE': '1', 08:22:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:22:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:22:26 INFO - 'NO_EM_RESTART': '1', 08:22:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:22:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:26 INFO - 'PWD': '/builds/slave/test', 08:22:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:22:26 INFO - 'SHELL': '/bin/bash', 08:22:26 INFO - 'SHLVL': '1', 08:22:26 INFO - 'TERM': 'linux', 08:22:26 INFO - 'TMOUT': '86400', 08:22:26 INFO - 'USER': 'cltbld', 08:22:26 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1460645738.372081-924134935', 08:22:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:26 INFO - '_': '/tools/buildbot/bin/python'} 08:22:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dQ2Ijhe7Sl2k-9MiK2saew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:22:26 INFO - mozversion application_buildid: 20160414073525 08:22:26 INFO - mozversion application_changeset: aef9d5c535ae78da48047a076c4a66bab551a2da 08:22:26 INFO - mozversion application_display_name: Nightly 08:22:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:22:26 INFO - mozversion application_name: Firefox 08:22:26 INFO - mozversion application_remotingname: firefox 08:22:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:22:26 INFO - mozversion application_vendor: Mozilla 08:22:26 INFO - mozversion application_version: 48.0a1 08:22:26 INFO - mozversion platform_buildid: 20160414073525 08:22:26 INFO - mozversion platform_changeset: aef9d5c535ae78da48047a076c4a66bab551a2da 08:22:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:22:26 INFO - mozversion platform_version: 48.0a1 08:22:26 INFO - using testdate: 1460647346 08:22:26 INFO - actual date: 1460647346 08:22:26 INFO - starting webserver on 'localhost:40051' 08:22:26 INFO - SUITE-START | Running 2 tests 08:22:26 INFO - TEST-START | dromaeo_css 08:22:26 INFO - operating with platform_type : linux_ 08:22:26 INFO - Initialising browser for dromaeo_css test... 08:22:26 INFO - TEST-INFO | started process 9992 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdbsSnp/profile http://localhost:40051/getInfo.html) 08:22:30 INFO - PROCESS | 9992 | __metrics Screen width/height:1600/1200 08:22:30 INFO - PROCESS | 9992 | colorDepth:24 08:22:30 INFO - PROCESS | 9992 | Browser inner width/height: 1024/697 08:22:30 INFO - PROCESS | 9992 | __metrics 08:22:32 ERROR - PROCESS | 9992 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:22:33 INFO - TEST-INFO | 9992: exit 0 08:22:33 INFO - Browser initialized. 08:22:33 INFO - Running cycle 1/1 for dromaeo_css test... 08:22:33 INFO - TEST-INFO | started process 10080 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdbsSnp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:22:45 INFO - PROCESS | 10080 | RSS: Main: 154750976 08:22:45 INFO - PROCESS | 10080 | 08:23:35 INFO - PROCESS | 10080 | 1460647415839 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] 08:25:48 INFO - PROCESS | 10080 | Cycle 1(1): loaded http://localhost:40051/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40051/tests/dromaeo/cssquery-ext.html) 08:25:49 INFO - PROCESS | 10080 | RSS: Main: 275169280 08:25:49 INFO - PROCESS | 10080 | 08:28:51 INFO - PROCESS | 10080 | Cycle 1(1): loaded http://localhost:40051/tests/dromaeo/cssquery-ext.html (next: http://localhost:40051/tests/dromaeo/cssquery-jquery.html) 08:28:52 INFO - PROCESS | 10080 | RSS: Main: 231079936 08:28:52 INFO - PROCESS | 10080 | 08:31:54 INFO - PROCESS | 10080 | Cycle 1(1): loaded http://localhost:40051/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40051/tests/dromaeo/cssquery-mootools.html) 08:31:55 INFO - PROCESS | 10080 | RSS: Main: 232464384 08:31:55 INFO - PROCESS | 10080 | 08:34:57 INFO - PROCESS | 10080 | Cycle 1(1): loaded http://localhost:40051/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40051/tests/dromaeo/cssquery-prototype.html) 08:34:57 INFO - PROCESS | 10080 | RSS: Main: 237449216 08:34:57 INFO - PROCESS | 10080 | 08:38:00 INFO - PROCESS | 10080 | Cycle 1(1): loaded http://localhost:40051/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40051/tests/dromaeo/cssquery-yui.html) 08:38:01 INFO - PROCESS | 10080 | RSS: Main: 214200320 08:38:01 INFO - PROCESS | 10080 | 08:41:04 INFO - PROCESS | 10080 | Cycle 1(1): loaded http://localhost:40051/tests/dromaeo/cssquery-yui.html (next: http://localhost:40051/tests/dromaeo/cssquery-dojo.html) 08:41:04 INFO - PROCESS | 10080 | RSS: Main: 265412608 08:41:04 INFO - PROCESS | 10080 | 08:41:04 INFO - PROCESS | 10080 | __start_tp_report 08:41:04 INFO - PROCESS | 10080 | _x_x_mozilla_page_load 08:41:04 INFO - PROCESS | 10080 | _x_x_mozilla_page_load_details 08:41:04 INFO - PROCESS | 10080 | |i|pagename|runs| 08:41:04 INFO - PROCESS | 10080 | |0;dojo.html;2647.2720001999455;2695.5417579011564;2704.0670968515856;2724.577690457977;2729.6587926509187;4655.045715628296;4663.720176789395;4698.647601429893;4720.197566413709;4760.33355330254;4695.389599352088;4711.764411779414;4731.408573928259;4801.711897286165;4826.348442960208;4259.297215959363;4306.267934451135;4368.1918845013615;4389;4493.3484644726495;4408.052268762215;4445.110977804436;4456.286994080948;4468.3074123510905;4492.2812350024005;4251.893702657428;4275.529691733938;4319.935200971988;4325.567443255681;4351.673624478177;4360.433143691332;4364.061726728769;4389.846355377546;4395.604395604379;4430.246858034142;4320.891977700551;4372.825086996516;4379.277419225824;4424.292113261863;4427.734335939822;4380.167768124078;4541.750203738826;4585.587297143273;4620.838270660511;4632.837850675211;5057.924131138036;5062.392512898439;5066.822661206877;5067;5079.619028572872;5080.187170052774;5098.082345177866;5100.209467532539;5110.514501122388;5115.386153661584;4535.206338890681;4650.162970665313;4712.104700106968;4733.786979585927;4735.550122738335;5126.487351264844;5130.1535246684625;5142.794288228429;5150.40770311419;5166.767495462713;4937.580305673986;4943.950560494421;4948.579370753454;4959.355283813154;5002.199648056294;4886.3403440535785;4964.8510544682995;5032.295478632995;5066.240063990357;5067.822626208065;4964.90070198594;5010.073136469765;5013.222950442687;5016.724080175552;5061.493850614909;4852.320675105488;4983.177775667047;5004.599632029502;5011.649184557119;5055.165897626924;4077.8776636700354;4186.832526698898;4220.219259436953;4261.147770445923;4267.231898258281;3688.797116158637;3689.096171438015;3693.963060369416;3708.9072773180887;3732.720045996561;4279.914401711948;4334.393184954109;4350.216960946997;4357.455318085239;4384.868453946387;5031.471695471996;5053.393592768818;5067.391912970467;5090.618203634742;5116.334876466036;4364.738115713068;4369.47566292047;4370.038591509926;4372.3878656988045;4406.669499787528;4433.778311084433;4521.389612402284;4533.274676051816;4535.297028960516;4573;4743.501932297059;4766.499517550607;4771.308160316735;4779.450363208275;4816.927746083811;4982.576480999156;5017.84946451607;5018.322526458881;5039.218921067094;5065.898682026265;4621.191291523903;4727.669063165546;4762.499937506651;4785.569298763128;4803.0153818467825;4953.380827396575;4969.577585905238;4987.376577927759;4988.42633097184;5016.573591244785;5024.196128619404;5048.091343558195;5063.961887813063;5067.822626208065;5077.213031980049;4756.429228492603;4901.485344038824;4926.655134140576;4969.105560998911;4977.054359671795;4874.268859671078;4891.804327826847;4908.1098301575375;4908.116539022867;4957.677750946177;4814.8796280093275;4845.8061677532505;4848.903021939612;4850.878728031827;4897.730624815669;4684.461286952044;4818.156822556109;4866.610671146229;4903.0193961208615;4933.235348520985;4691.08523837862;4707.4821769606;4714.104320179155;4715.009847931836;4716.127516409475 08:41:04 INFO - PROCESS | 10080 | |1;ext.html;557.7099908047816;583.1515145463351;602.5240060352319;606.5996442348049;611.571899670231;32850.342993140155;33684.663153368456;34105;34570.65429345706;34573.481397779055;36915;37382;37480.81259593705;37527.43708844363;37583.43624845623;7243.203247642755;7802.726904558327;8012.839743205132;8015.799605009863;9594.616215351412;9726.319157658967;9905.257105717064;9907.752306192368;9908.504574771268;9913.306068575203;9820.705378838646;9916;9936.354136981074;9947.55236014381;9951.353162044445;9736.561854716554;9853.211743060538;9863.60545578176;9869.259805514615;9872.35829671069;9691.806163876754;9807.31348805584;9812.36219645728;9824.557894894748;9826.705198844045;36345.81827090874;36749;36836.44745328822;36843.631563684285;36908.446373304425;3050.6339239291206;3081.876724931;3096.5819614352;3278.2623909620143;3557.128503516655;28444.431111377864;29266.70733292661;29375.2656183595;29643.258918527208;30205.395892082255;3468.0465666339082;3470.4273794823825;3479.3215323012023;3488.284901595167;3563.4120370138894;232508;233038;234682;235183.8240808802;236343;55367.446325537036;55378.16932746012;55535.444645553835;55588;55694.44305556973;58022.41977580255;58198.4180158193;58362.70818645965;58557.4144258552;58564.414355856745;14047.367868445945;14706.852931470763;14725.337359818834;14735.926320368544;14745.336459859333;9865;9876.555555000043;9880.851787223197;9882.851757223647;9890.802183956424;18551.90724046371;18572.164252608396;18723.25106995705;18755.718664220047;18782.342618008304;6986.16166060076;7213.89179162313;7216.386607138452;7267.491275610657;7287.526310789782;945.6690158444627;950.8621249918862;974.5565767575736;992.6995635717234;1074.752806854428;27569.448611027667;27747.72252277492;28035.579466308023;28169.57745633817;28300.85849570739;994.2046362909788;1055.8469021991768;1077.8652668416448;1082.86464191976;1145.4215621111452;13797.310134493235;13810.447582096604;13952.16287022782;13988.300584970913;14054.367553460119;317934;410023;420131;420361;421626;49683.25475117876;50442.24336634953;50983.49016509787;51126.23310650343;51161;1164.4527072276016;1235.215638069832;1279.3858947704969;1281.7052078022107;1387.9867696581553;26037.609435858856;29219.707802921697;29256.853715731286;29607.85196074006;29730.405391891607;40362.798186008884;41047.38428923628;41215.175696486505;41256.381154282106;41273.587264128175;235948;236219;238196;239286;239488;25433.87283063573;26382.472350552496;26445.206643800717;26460.470790584466;26486.470270594866;42441.787791060844;42854.78572607117;43154.56845431506;44038.11923761571;44174.779126104164;34630.82684586561;35073.473897892065;35853.64146358607;35856;35967.28065438624;35626;36233.63766362303;36328.63671363253;36412.81793591015;36662.8166859164;35976;36575.26849463049;36726.08184795402;37021.62978370182;37171.44242836306;30639.693603063683;32711;32768;32899.039086482335;32934.34131317312;24967.87516062408;25341.239762807145;25362.492750145262;25412.85642146145;25638.743612563634 08:41:04 INFO - PROCESS | 10080 | |2;jquery.html;370.3038288018524;372.32980634857256;391.723834696539;396.50634959475457;401.2336437404554;15687.52937411878;17026.233819478122;17098.914505427485;17126.828731712678;17209.913950430247;10298.279120461571;10626.203034772403;10844;10857.077148442391;10886.891131088687;4652.953470465286;4805.135075686375;5114.28400023997;5157.381114266274;5223.895522089556;4814.1334559779225;5260.368755749316;5265.0259701955065;5269.8946021079555;5283.154695248761;5190.32525771651;5193.766280517367;5213.426523082458;5228.633995620289;5244.187150991603;5066.873328166788;5145.794168233266;5164.328637277167;5183.144781111112;5221.843344699665;4626;4653.953460465385;4664.953350466486;4955.851324460236;4962.528559786814;19747.21011159552;19772.604547908963;19784.901075494676;20038.79961200384;20205.19179232829;1730.679824232521;1861.776586809578;2007.8192962633286;2134.509062915538;2341.789238968484;9669.661561845372;10811.675649730521;12881.325427694339;13036.283004434752;13710.38303276355;1685.7302831547017;1696.9660606787795;1790.4807605794304;1809.9185536650882;1861.1624768853935;49366.15286255163;49423.75288123573;54497.99999999961;66189;69362;9608.231341492663;9738.036467871634;9824.705258842247;9930.453825039693;10003.299769016245;11900.64298071042;12843.165194262343;13220.140690855063;13259.469621215043;13581.524646637321;7197.4961752677855;7233.45749068822;7263.418926485869;7310.854330339704;7343.559386436831;6763.6618169092335;6855.5543889647015;6999.405050570656;7078.079849619619;7094.7162113515915;4132.834686612562;4174.7077704561;4185.455890734246;4233.640140588023;4570.520095390003;1764.126757255167;1788.2399980008445;1790.6955817511055;1803.5491127218195;1812.3566134022233;869.4696235296464;879.2658130461136;912.4479689787715;926.129438327983;1012.2054187462807;16011.199440027953;16560.254788534545;16588.6682266354;16865.07242101696;17052;863.7020228021322;868.1318681318681;897.228383590112;899.6896070855545;940.548536702373;8975.596098175598;9324.300677449219;9396.436213827192;9426.62293508252;9622.47076410804;392054;392170;407868;410129;410572;76706;79314;79974.60012700016;79999;80956;934.5841100710255;940.8071345374182;954.1079091049891;982.1553464020936;994.721477986165;14414.567562972708;14444;14636.195009274592;14667.779983300046;14851.628709282355;32199.678003220604;33321;33590.49614255837;33689.494657580646;34245.82877085599;48228;48586.02827943351;48628.75685621549;48788;48899.75550122369;7309.305615966475;7483.513571617827;7535.54786712799;7537.660805263886;7544;10892.18308626872;10975.451227438756;11183.552657893919;11402.20184587071;11518;9486.95256523713;9540.427574345562;9724;9983.301168918397;10169.084782369622;9596.9040309596;9868.851967220355;9873.111419972238;9887.901120988698;9911.30620856562;9717.465539395118;9983.650572229937;10011;10024.24818138657;10322.483875806029;7381.077365329334;7438.814029649302;7441.590712510864;7480.364169045474;7649.9617501912135;7467.103947526114;9441.433513988908;9834.01659834011;9881.555330010311;10158.985192458475 08:41:04 INFO - PROCESS | 10080 | |3;mootools.html;1304.6216597186803;1411.9788203176954;1468.016428992575;1573.819010813756;1791.4625612316302;7512;7830.56931868747;7833.5299882006975;7850.960745196273;7870.252326029025;7689.9231007689905;7818.569978651172;7843.490173138742;7861.56761378124;7867.8426431471335;1879.6710575649274;2074.077035719102;2090.968635470469;2183.355910006544;2259.062489067035;2213.391317387715;2229.375774783063;2232.598132336179;2234.307364716935;2236.0049777848863;2109.335559298816;2138.3905586907736;2144.1209104267255;2144.1423430627797;2145.5816115857415;1874.7562816833793;2170.359743875553;2228.0864845413466;2237.8433509654333;2239.9776002239932;2155.4072630026712;2160.751513575943;2174.945626359338;2175.086463685256;2195.1548653768414;7766.728164514215;7772.922270777333;7809.648565814552;7832.138464768871;7873.291403773631;4519.5480451954545;4669.859904202879;4680.321353403738;4696.929546056812;4713.151632706112;2985.4327677741157;2998.235449960246;3049.9085027449214;3053.2977415194628;3059.938801223985;984.7045886234101;993.696922438656;1018.8981101889751;1019.9337043092175;1028.547439126782;10974.670759877217;11012.39431831249;11015.669529914116;11032.944835275852;11034.668959931216;4173.207090652766;4282.657387409;4466.1067786442845;4501.0547784964865;4527.162474942146;8585.957070214608;8651.610677519528;8711.433756805787;8724.78188045304;8728.432651877607;3914.1584559319313;4721.787519561628;4745.525447455296;4753.001869607421;4755.310479980383;4229.365595160751;4317.0934103838545;4321.308590625547;4322.308430651081;4352.673549483801;3450.7929524228625;3489.65103489649;3545.982270088685;3548.698360639323;3619.4570814377525;1066.0991462214417;1087.0705546757408;1094.9069329107115;1098.3025778630627;1107.534835369147;826.7726375246855;861.9224269815621;924.8150369926042;935.7941252924346;940.6425558287943;5510.724463776875;5669.064604340238;5761.308642962787;5765.077587585966;5810.912836307459;897.4166791585521;898.4788822482944;910.1762904571374;914.4284821986258;935.1069728409353;3630.219502806909;3792.2605092007348;3977.125032492847;3977.482927219443;3983.50206224222;9618.182454491307;10023.198144148451;10098.697039088838;10132.240081993732;10157.746056348502;9899.60401583943;9937.850932236022;10004.399736015717;10099.343542669703;10135.543900524493;7184.173820010766;7267.672954717156;7316.9390438386135;7340.11918569775;7392.741254056083;5383.1117865553315;5507.779688812403;5562.666240025612;5567.4432556744005;5580.330360356783;9077.90922090797;9268.675596354095;9300.209482193819;9312;9315.72052838416;9056.456612603264;9243.121903419164;9463;9501.192398645917;9516.619335226791;5807.651540907559;5993.580449368676;6002.639841609517;6497.252815926229;6641.634710090992;6626.237982632059;7403.296686814744;7610.961945190239;7638.656260468181;7662.73180438682;6670.9332906670315;6807.795766127024;6808.148981377328;6917.93082069193;6935.826604334932;6533.281339052605;6584.76953306632;6596.8350791230605;6633.270340262664;6795.014722865256;6331.145295385249;6367.044943258548;6384.489240860813;6394.616323020634;6431.131797207504;4708;4849.854504364875;4956.306117143531;4980.203167493184;4990.725510096834;4886.828960986349;4964.553190212898;4967.850964471072;5054.2671312660195;5083.085044691991 08:41:04 INFO - PROCESS | 10080 | |4;prototype.html;318.7672998710941;319.2481705583351;321.7699344968347;325.941330560499;326.82678180564295;5065;5118.48815118488;5133.409657889344;5134.974325128378;5174.741262936857;5066.037452883958;5076.111680455915;5076.898462030757;5080.618953578487;5085.720285384303;3808.5048943637357;3842.559040359865;4019.9598004019876;4026.094128821021;4028.7179897407195;3995.9600403996023;4013.1371755072655;4022.9798851005703;4024.798760062;4046.3525835866267;3764.8305826237884;3993.9201215975663;4000.039990402297;4003.1593365393155;4007.458993035932;3841.7310788244836;3920.1963597462595;3948.5261768587666;3953.683705303569;3971.801409929492;3529.9647003529894;3542.0967653248513;3549.2901419715904;3550.5739311282555;3557.6620221078956;4924.507549245047;4930.778114984834;4936.086823937583;4954.950450495521;4956.107900577895;4329.523752387235;4549.181147393468;4550.840720574764;4582.518835522255;4611.26219804833;5308.787648494055;5316.946830531722;5327.760250788724;5338.62629615927;5342.652727572696;3780.319542482352;3783;3790.2608991246716;3793.1655035892336;3804.8478060877533;5521.723913804334;5557.249771280865;5560.4161563036105;5577.69322687252;5578.967890940148;3852.788096654655;3876.3604005339366;3878.204967981557;3885.1646895917515;3887.125396785757;3914.3345631242187;3928.46965659638;3935.252302062599;3940.4877365942243;3953.584873588289;4286.207051695446;4538.704984176018;4543.704659197208;4550.977245113753;4553.954460455353;5385.407605163429;5408.781774843961;5415.6479828811;5416.8104116355735;5423.322084739408;1360.6122255157234;1375.690469644342;1380.5996261084374;1380.9573771802225;1381.1920026784444;874.6370256343673;909.6406919266852;925.7824411263348;928.122923836981;942.8444306689456;4688.296755486705;4688.742119183409;4707.505711900201;4718.811247550059;4719.079779443045;5483.314585676791;5509.228707980886;5517.282753242133;5530.419305972895;5535.889282214333;4555.293929440942;4748.453927798348;4749.4063242094735;4754.78603462845;4759.50025247351;2947.292649764041;2963.6888126746812;2967.569702393184;2974.672785993539;2984.4180384825186;5244;5250.238715386324;5251;5257.553107985864;5260.605454590845;5530;5683.175939488751;5702.6293290935955;5714.514266287329;5727.799527016535;5197.194434862602;5247.527722504993;5249.186376111708;5261.447548007481;5272.604554658416;5421.159720243369;5564.721763911869;5572.804951826666;5587.804426845203;5600.803971860965;5451.781928722965;5479.068558345011;5489.807856724996;5492.2424824055915;5493.615446918678;5216.713080780593;5240.135377662643;5240.825057601053;5245.868853278698;5247.137266270572;3806.733528652968;3882.087709388235;3900.9609903901733;3901.2197560488585;3921.9607803921594;5521.309836270466;5529.972350138223;5534.418886016911;5538.252335934759;5541.33503979525;5288.656237344714;5339.225812257123;5372.1941708744;5392.11521835816;5398.568114550905;5272.578193744414;5326.6537675050995;5350.598705097055;5369.436209197978;5380.058489764354;5056.6207534434325;5274.261603375454;5304.575633949352;5309.973450132725;5317.654352467077;5201.661891977009;5381.946180538301;5403.189521571796;5404.675719456845;5418.485243901823;5276.445973172915;5276.9472305278;5280;5285.894282114413;5291.7354132294 08:41:04 INFO - PROCESS | 10080 | |5;yui.html;647.7214797637016;723.7864829875186;756.5725365168678;773.3272053313618;793.5873345860152;11229.719257018578;11313.264637798537;11338.60314888979;11359.261647992886;11773.470193841276;12458.750824983495;12627.36863156843;12647.241165530051;12657.114002019862;12668.80996785049;807.9313258373031;808.454293351988;814.4258297899967;816.0859836982559;816.1348970091692;642.1780121444558;775.7246177606953;809.4536188073057;812.2689579378577;812.6383759227147;846.0524212881581;846.4794151596785;847.3814115695546;848.3679658654311;848.8047749017729;664.1498881431775;840.9117042710519;841.0286119531951;841.478283464253;841.7979684875647;601.9518438524907;618.3847072163181;619.2414292491707;619.5260625621403;619.7087368936593;11743.177977541576;11828.763424731456;11835.526578936831;11835.88164118365;11864.881351186465;11954;12189.329586872718;12277.877221227764;12544.560940367135;12802.74394512114;8987.14622110905;9099.863502047474;9106.544672766335;9128.269738420977;9225.308101892386;3246.318273162639;3272.149241197282;3305.6694330566993;3315.336932613463;3405.880794172217;46263.53736462626;46279.30581041287;46295.76852115718;46309.53690463086;46385.768071160106;9464.716058518256;9859.457729824786;9955.55200016001;10196.490175491344;10203.642872499428;17188.22652980594;17204.827951720574;17336.65326693459;17731.29074837018;18182.18180181895;6841.897371539431;6918.377346038881;7053.365197132282;7061.1173603299585;7090.680919358641;3621.6740493355196;3626.38351480249;3660.4692319613505;3668.706503479715;3733.5893051764283;2921.6347956505438;3069.171323742577;3072.738817200563;3077.1845460952864;3077.6460707018978;542.0216509200931;544.5099410530554;550.6921062476619;553.9446055394428;557.8382269141985;575.7409165875373;604.7943699142224;611.0711718188329;612.295859761278;612.7947137708828;7303;7452.403807695371;7517.624118794039;7891.881621775678;7925.762227133196;512.9563987061142;586.2183937217928;646.612032780328;648.4423395879539;661.206552137437;3539.734519911017;3769.679577235911;3782.319182547113;3806.5812760596314;3810.466534685146;52160;52872.47127528753;52902;52922.47077529175;53155;45182.54817451849;46687.29969050467;47011.29483057757;47463.99999999931;48301.275480867815;41763.7911810439;42774.57225427706;42866.571334286884;43184.56815431868;43730.125397492506;7493.213212612815;7513.924860751323;7539.585322807079;7684.385249179941;7843.137254901842;25668;25697.547711163552;26680.8665956669;27488.45023099567;27618.861905690344;31479.21301967469;34402;34912.825435872655;35160.94517164489;35784;10295.53670084833;10357.585696572052;10622.468876556295;10677.679669609925;10700.89299106999;11164;11372.43137843088;11385.203035787416;12142.696432589257;12270.938645306716;10065.647702330383;10366.222533309881;10391.37651740898;10610.363378197333;10672.62645807393;10369.792604148026;10829.891701082888;10834.458277085956;10994.175436842108;11254.83117753218;10358.430286334324;10513.474326283807;10899.455027248765;10993.835092473779;11192.608258710907;9355.298352623444;9652.327344118834;9669.129778319984;9815.11663950248;9923.851142232728;8660.523671198145;8946.284297256334;9327.300452465957;9365.297602679962;9460.526973651153 08:41:04 INFO - PROCESS | 10080 | __end_tp_report 08:41:04 INFO - PROCESS | 10080 | __start_cc_report 08:41:04 INFO - PROCESS | 10080 | _x_x_mozilla_cycle_collect,1196 08:41:04 INFO - PROCESS | 10080 | __end_cc_report 08:41:04 INFO - PROCESS | 10080 | __startTimestamp1460648464496__endTimestamp 08:41:04 INFO - PROCESS | 10080 | 08:41:04 INFO - PROCESS | 10080 | ------- Summary: start ------- 08:41:04 INFO - PROCESS | 10080 | Number of tests: 6 08:41:04 INFO - PROCESS | 10080 | 08:41:04 INFO - PROCESS | 10080 | [#0] dojo.html Cycles:165 Average:4653.07 Median:4760.33 stddev:477.33 (10.0%) stddev-sans-first:452.12 08:41:04 INFO - PROCESS | 10080 | Values: 2647.3 2695.5 2704.1 2724.6 2729.7 4655.0 4663.7 4698.6 4720.2 4760.3 4695.4 4711.8 4731.4 4801.7 4826.3 4259.3 4306.3 4368.2 4389.0 4493.3 4408.1 4445.1 4456.3 4468.3 4492.3 4251.9 4275.5 4319.9 4325.6 4351.7 4360.4 4364.1 4389.8 4395.6 4430.2 4320.9 4372.8 4379.3 4424.3 4427.7 4380.2 4541.8 4585.6 4620.8 4632.8 5057.9 5062.4 5066.8 5067.0 5079.6 5080.2 5098.1 5100.2 5110.5 5115.4 4535.2 4650.2 4712.1 4733.8 4735.6 5126.5 5130.2 5142.8 5150.4 5166.8 4937.6 4944.0 4948.6 4959.4 5002.2 4886.3 4964.9 5032.3 5066.2 5067.8 4964.9 5010.1 5013.2 5016.7 5061.5 4852.3 4983.2 5004.6 5011.6 5055.2 4077.9 4186.8 4220.2 4261.1 4267.2 3688.8 3689.1 3694.0 3708.9 3732.7 4279.9 4334.4 4350.2 4357.5 4384.9 5031.5 5053.4 5067.4 5090.6 5116.3 4364.7 4369.5 4370.0 4372.4 4406.7 4433.8 4521.4 4533.3 4535.3 4573.0 4743.5 4766.5 4771.3 4779.5 4816.9 4982.6 5017.8 5018.3 5039.2 5065.9 4621.2 4727.7 4762.5 4785.6 4803.0 4953.4 4969.6 4987.4 4988.4 5016.6 5024.2 5048.1 5064.0 5067.8 5077.2 4756.4 4901.5 4926.7 4969.1 4977.1 4874.3 4891.8 4908.1 4908.1 4957.7 4814.9 4845.8 4848.9 4850.9 4897.7 4684.5 4818.2 4866.6 4903.0 4933.2 4691.1 4707.5 4714.1 4715.0 4716.1 08:41:04 INFO - PROCESS | 10080 | 08:41:04 INFO - PROCESS | 10080 | [#1] ext.html Cycles:180 Average:45225.74 Median:36379.32 stddev:79201.59 (217.7%) stddev-sans-first:79352.76 08:41:04 INFO - PROCESS | 10080 | Values: 557.7 583.2 602.5 606.6 611.6 32850.3 33684.7 34105.0 34570.7 34573.5 36915.0 37382.0 37480.8 37527.4 37583.4 7243.2 7802.7 8012.8 8015.8 9594.6 9726.3 9905.3 9907.8 9908.5 9913.3 9820.7 9916.0 9936.4 9947.6 9951.4 9736.6 9853.2 9863.6 9869.3 9872.4 9691.8 9807.3 9812.4 9824.6 9826.7 36345.8 36749.0 36836.4 36843.6 36908.4 3050.6 3081.9 3096.6 3278.3 3557.1 28444.4 29266.7 29375.3 29643.3 30205.4 3468.0 3470.4 3479.3 3488.3 3563.4 232508.0 233038.0 234682.0 235183.8 236343.0 55367.4 55378.2 55535.4 55588.0 55694.4 58022.4 58198.4 58362.7 58557.4 58564.4 14047.4 14706.9 14725.3 14735.9 14745.3 9865.0 9876.6 9880.9 9882.9 9890.8 18551.9 18572.2 18723.3 18755.7 18782.3 6986.2 7213.9 7216.4 7267.5 7287.5 945.7 950.9 974.6 992.7 1074.8 27569.4 27747.7 28035.6 28169.6 28300.9 994.2 1055.8 1077.9 1082.9 1145.4 13797.3 13810.4 13952.2 13988.3 14054.4 317934.0 410023.0 420131.0 420361.0 421626.0 49683.3 50442.2 50983.5 51126.2 51161.0 1164.5 1235.2 1279.4 1281.7 1388.0 26037.6 29219.7 29256.9 29607.9 29730.4 40362.8 41047.4 41215.2 41256.4 41273.6 235948.0 236219.0 238196.0 239286.0 239488.0 25433.9 26382.5 26445.2 26460.5 26486.5 42441.8 42854.8 43154.6 44038.1 44174.8 34630.8 35073.5 35853.6 35856.0 35967.3 35626.0 36233.6 36328.6 36412.8 36662.8 35976.0 36575.3 36726.1 37021.6 37171.4 30639.7 32711.0 32768.0 32899.0 32934.3 24967.9 25341.2 25362.5 25412.9 25638.7 08:41:04 INFO - PROCESS | 10080 | 08:41:04 INFO - PROCESS | 10080 | [#2] jquery.html Cycles:180 Average:23950.93 Median:48843.88 stddev:66293.04 (135.7%) stddev-sans-first:66455.36 08:41:04 INFO - PROCESS | 10080 | Values: 370.3 372.3 391.7 396.5 401.2 15687.5 17026.2 17098.9 17126.8 17209.9 10298.3 10626.2 10844.0 10857.1 10886.9 4653.0 4805.1 5114.3 5157.4 5223.9 4814.1 5260.4 5265.0 5269.9 5283.2 5190.3 5193.8 5213.4 5228.6 5244.2 5066.9 5145.8 5164.3 5183.1 5221.8 4626.0 4654.0 4665.0 4955.9 4962.5 19747.2 19772.6 19784.9 20038.8 20205.2 1730.7 1861.8 2007.8 2134.5 2341.8 9669.7 10811.7 12881.3 13036.3 13710.4 1685.7 1697.0 1790.5 1809.9 1861.2 49366.2 49423.8 54498.0 66189.0 69362.0 9608.2 9738.0 9824.7 9930.5 10003.3 11900.6 12843.2 13220.1 13259.5 13581.5 7197.5 7233.5 7263.4 7310.9 7343.6 6763.7 6855.6 6999.4 7078.1 7094.7 4132.8 4174.7 4185.5 4233.6 4570.5 1764.1 1788.2 1790.7 1803.5 1812.4 869.5 879.3 912.4 926.1 1012.2 16011.2 16560.3 16588.7 16865.1 17052.0 863.7 868.1 897.2 899.7 940.5 8975.6 9324.3 9396.4 9426.6 9622.5 392054.0 392170.0 407868.0 410129.0 410572.0 76706.0 79314.0 79974.6 79999.0 80956.0 934.6 940.8 954.1 982.2 994.7 14414.6 14444.0 14636.2 14667.8 14851.6 32199.7 33321.0 33590.5 33689.5 34245.8 48228.0 48586.0 48628.8 48788.0 48899.8 7309.3 7483.5 7535.5 7537.7 7544.0 10892.2 10975.5 11183.6 11402.2 11518.0 9487.0 9540.4 9724.0 9983.3 10169.1 9596.9 9868.9 9873.1 9887.9 9911.3 9717.5 9983.7 10011.0 10024.2 10322.5 7381.1 7438.8 7441.6 7480.4 7650.0 7467.1 9441.4 9834.0 9881.6 10159.0 08:41:04 INFO - PROCESS | 10080 | 08:41:04 INFO - PROCESS | 10080 | [#3] mootools.html Cycles:180 Average:5225.85 Median:4974.03 stddev:2924.99 (58.8%) stddev-sans-first:2918.35 08:41:04 INFO - PROCESS | 10080 | Values: 1304.6 1412.0 1468.0 1573.8 1791.5 7512.0 7830.6 7833.5 7851.0 7870.3 7689.9 7818.6 7843.5 7861.6 7867.8 1879.7 2074.1 2091.0 2183.4 2259.1 2213.4 2229.4 2232.6 2234.3 2236.0 2109.3 2138.4 2144.1 2144.1 2145.6 1874.8 2170.4 2228.1 2237.8 2240.0 2155.4 2160.8 2174.9 2175.1 2195.2 7766.7 7772.9 7809.6 7832.1 7873.3 4519.5 4669.9 4680.3 4696.9 4713.2 2985.4 2998.2 3049.9 3053.3 3059.9 984.7 993.7 1018.9 1019.9 1028.5 10974.7 11012.4 11015.7 11032.9 11034.7 4173.2 4282.7 4466.1 4501.1 4527.2 8586.0 8651.6 8711.4 8724.8 8728.4 3914.2 4721.8 4745.5 4753.0 4755.3 4229.4 4317.1 4321.3 4322.3 4352.7 3450.8 3489.7 3546.0 3548.7 3619.5 1066.1 1087.1 1094.9 1098.3 1107.5 826.8 861.9 924.8 935.8 940.6 5510.7 5669.1 5761.3 5765.1 5810.9 897.4 898.5 910.2 914.4 935.1 3630.2 3792.3 3977.1 3977.5 3983.5 9618.2 10023.2 10098.7 10132.2 10157.7 9899.6 9937.9 10004.4 10099.3 10135.5 7184.2 7267.7 7316.9 7340.1 7392.7 5383.1 5507.8 5562.7 5567.4 5580.3 9077.9 9268.7 9300.2 9312.0 9315.7 9056.5 9243.1 9463.0 9501.2 9516.6 5807.7 5993.6 6002.6 6497.3 6641.6 6626.2 7403.3 7611.0 7638.7 7662.7 6670.9 6807.8 6808.1 6917.9 6935.8 6533.3 6584.8 6596.8 6633.3 6795.0 6331.1 6367.0 6384.5 6394.6 6431.1 4708.0 4849.9 4956.3 4980.2 4990.7 4886.8 4964.6 4967.9 5054.3 5083.1 08:41:04 INFO - PROCESS | 10080 | 08:41:04 INFO - PROCESS | 10080 | [#4] prototype.html Cycles:180 Average:4456.01 Median:5083.17 stddev:1297.74 (25.5%) stddev-sans-first:1263.68 08:41:04 INFO - PROCESS | 10080 | Values: 318.8 319.2 321.8 325.9 326.8 5065.0 5118.5 5133.4 5135.0 5174.7 5066.0 5076.1 5076.9 5080.6 5085.7 3808.5 3842.6 4020.0 4026.1 4028.7 3996.0 4013.1 4023.0 4024.8 4046.4 3764.8 3993.9 4000.0 4003.2 4007.5 3841.7 3920.2 3948.5 3953.7 3971.8 3530.0 3542.1 3549.3 3550.6 3557.7 4924.5 4930.8 4936.1 4955.0 4956.1 4329.5 4549.2 4550.8 4582.5 4611.3 5308.8 5316.9 5327.8 5338.6 5342.7 3780.3 3783.0 3790.3 3793.2 3804.8 5521.7 5557.2 5560.4 5577.7 5579.0 3852.8 3876.4 3878.2 3885.2 3887.1 3914.3 3928.5 3935.3 3940.5 3953.6 4286.2 4538.7 4543.7 4551.0 4554.0 5385.4 5408.8 5415.6 5416.8 5423.3 1360.6 1375.7 1380.6 1381.0 1381.2 874.6 909.6 925.8 928.1 942.8 4688.3 4688.7 4707.5 4718.8 4719.1 5483.3 5509.2 5517.3 5530.4 5535.9 4555.3 4748.5 4749.4 4754.8 4759.5 2947.3 2963.7 2967.6 2974.7 2984.4 5244.0 5250.2 5251.0 5257.6 5260.6 5530.0 5683.2 5702.6 5714.5 5727.8 5197.2 5247.5 5249.2 5261.4 5272.6 5421.2 5564.7 5572.8 5587.8 5600.8 5451.8 5479.1 5489.8 5492.2 5493.6 5216.7 5240.1 5240.8 5245.9 5247.1 3806.7 3882.1 3901.0 3901.2 3922.0 5521.3 5530.0 5534.4 5538.3 5541.3 5288.7 5339.2 5372.2 5392.1 5398.6 5272.6 5326.7 5350.6 5369.4 5380.1 5056.6 5274.3 5304.6 5310.0 5317.7 5201.7 5381.9 5403.2 5404.7 5418.5 5276.4 5276.9 5280.0 5285.9 5291.7 08:41:04 INFO - PROCESS | 10080 | 08:41:04 INFO - PROCESS | 10080 | [#5] yui.html Cycles:180 Average:12502.38 Median:46302.65 stddev:14274.38 (30.8%) stddev-sans-first:14286.66 08:41:04 INFO - PROCESS | 10080 | Values: 647.7 723.8 756.6 773.3 793.6 11229.7 11313.3 11338.6 11359.3 11773.5 12458.8 12627.4 12647.2 12657.1 12668.8 807.9 808.5 814.4 816.1 816.1 642.2 775.7 809.5 812.3 812.6 846.1 846.5 847.4 848.4 848.8 664.1 840.9 841.0 841.5 841.8 602.0 618.4 619.2 619.5 619.7 11743.2 11828.8 11835.5 11835.9 11864.9 11954.0 12189.3 12277.9 12544.6 12802.7 8987.1 9099.9 9106.5 9128.3 9225.3 3246.3 3272.1 3305.7 3315.3 3405.9 46263.5 46279.3 46295.8 46309.5 46385.8 9464.7 9859.5 9955.6 10196.5 10203.6 17188.2 17204.8 17336.7 17731.3 18182.2 6841.9 6918.4 7053.4 7061.1 7090.7 3621.7 3626.4 3660.5 3668.7 3733.6 2921.6 3069.2 3072.7 3077.2 3077.6 542.0 544.5 550.7 553.9 557.8 575.7 604.8 611.1 612.3 612.8 7303.0 7452.4 7517.6 7891.9 7925.8 513.0 586.2 646.6 648.4 661.2 3539.7 3769.7 3782.3 3806.6 3810.5 52160.0 52872.5 52902.0 52922.5 53155.0 45182.5 46687.3 47011.3 47464.0 48301.3 41763.8 42774.6 42866.6 43184.6 43730.1 7493.2 7513.9 7539.6 7684.4 7843.1 25668.0 25697.5 26680.9 27488.5 27618.9 31479.2 34402.0 34912.8 35160.9 35784.0 10295.5 10357.6 10622.5 10677.7 10700.9 11164.0 11372.4 11385.2 12142.7 12270.9 10065.6 10366.2 10391.4 10610.4 10672.6 10369.8 10829.9 10834.5 10994.2 11254.8 10358.4 10513.5 10899.5 10993.8 11192.6 9355.3 9652.3 9669.1 9815.1 9923.9 8660.5 8946.3 9327.3 9365.3 9460.5 08:41:04 INFO - PROCESS | 10080 | -------- Summary: end -------- 08:41:04 INFO - PROCESS | 10080 | 08:41:05 INFO - TEST-INFO | 10080: exit 0 08:41:05 INFO - TEST-OK | dromaeo_css | took 1118973ms 08:41:05 INFO - TEST-START | kraken 08:41:05 INFO - operating with platform_type : linux_ 08:41:05 INFO - Initialising browser for kraken test... 08:41:05 INFO - TEST-INFO | started process 10258 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpra1nzp/profile http://localhost:40051/getInfo.html) 08:41:09 INFO - PROCESS | 10258 | __metrics Screen width/height:1600/1200 08:41:09 INFO - PROCESS | 10258 | colorDepth:24 08:41:09 INFO - PROCESS | 10258 | Browser inner width/height: 1024/697 08:41:09 INFO - PROCESS | 10258 | __metrics 08:41:10 ERROR - PROCESS | 10258 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:41:11 INFO - TEST-INFO | 10258: exit 0 08:41:11 INFO - Browser initialized. 08:41:11 INFO - Running cycle 1/1 for kraken test... 08:41:11 INFO - TEST-INFO | started process 10341 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpra1nzp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:41:23 INFO - PROCESS | 10341 | RSS: Main: 154603520 08:41:23 INFO - PROCESS | 10341 | 08:41:26 INFO - PROCESS | 10341 | Cycle 1(1): loaded http://localhost:40051/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40051/tests/kraken/driver.html?testName=audio-beat-detection) 08:41:27 INFO - PROCESS | 10341 | RSS: Main: 209309696 08:41:27 INFO - PROCESS | 10341 | 08:41:29 INFO - PROCESS | 10341 | Cycle 1(1): loaded http://localhost:40051/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40051/tests/kraken/driver.html?testName=audio-dft) 08:41:30 INFO - PROCESS | 10341 | RSS: Main: 194625536 08:41:30 INFO - PROCESS | 10341 | 08:41:33 INFO - PROCESS | 10341 | Cycle 1(1): loaded http://localhost:40051/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40051/tests/kraken/driver.html?testName=audio-fft) 08:41:34 INFO - PROCESS | 10341 | RSS: Main: 265302016 08:41:34 INFO - PROCESS | 10341 | 08:41:36 INFO - PROCESS | 10341 | Cycle 1(1): loaded http://localhost:40051/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40051/tests/kraken/driver.html?testName=audio-oscillator) 08:41:37 INFO - PROCESS | 10341 | RSS: Main: 174264320 08:41:37 INFO - PROCESS | 10341 | 08:41:39 INFO - PROCESS | 10341 | Cycle 1(1): loaded http://localhost:40051/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40051/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:41:39 INFO - PROCESS | 10341 | RSS: Main: 178929664 08:41:39 INFO - PROCESS | 10341 | 08:41:43 INFO - PROCESS | 10341 | Cycle 1(1): loaded http://localhost:40051/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40051/tests/kraken/driver.html?testName=imaging-darkroom) 08:41:43 INFO - PROCESS | 10341 | RSS: Main: 214237184 08:41:43 INFO - PROCESS | 10341 | 08:41:47 INFO - PROCESS | 10341 | Cycle 1(1): loaded http://localhost:40051/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40051/tests/kraken/driver.html?testName=imaging-desaturate) 08:41:47 INFO - PROCESS | 10341 | RSS: Main: 214818816 08:41:47 INFO - PROCESS | 10341 | 08:41:50 INFO - PROCESS | 10341 | Cycle 1(1): loaded http://localhost:40051/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40051/tests/kraken/driver.html?testName=json-parse-financial) 08:41:51 INFO - PROCESS | 10341 | RSS: Main: 214888448 08:41:51 INFO - PROCESS | 10341 | 08:41:52 INFO - PROCESS | 10341 | Cycle 1(1): loaded http://localhost:40051/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40051/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:41:53 INFO - PROCESS | 10341 | RSS: Main: 200871936 08:41:53 INFO - PROCESS | 10341 | 08:41:55 INFO - PROCESS | 10341 | Cycle 1(1): loaded http://localhost:40051/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40051/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:41:55 INFO - PROCESS | 10341 | RSS: Main: 202948608 08:41:55 INFO - PROCESS | 10341 | 08:41:58 INFO - PROCESS | 10341 | Cycle 1(1): loaded http://localhost:40051/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40051/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:41:58 INFO - PROCESS | 10341 | RSS: Main: 218714112 08:41:58 INFO - PROCESS | 10341 | 08:42:01 INFO - PROCESS | 10341 | Cycle 1(1): loaded http://localhost:40051/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40051/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:42:02 INFO - PROCESS | 10341 | RSS: Main: 224116736 08:42:02 INFO - PROCESS | 10341 | 08:42:05 INFO - PROCESS | 10341 | Cycle 1(1): loaded http://localhost:40051/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40051/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:42:05 INFO - PROCESS | 10341 | RSS: Main: 217153536 08:42:05 INFO - PROCESS | 10341 | 08:42:07 INFO - PROCESS | 10341 | Cycle 1(1): loaded http://localhost:40051/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40051/tests/kraken/driver.html?testName=ai-astar) 08:42:07 INFO - PROCESS | 10341 | RSS: Main: 280956928 08:42:07 INFO - PROCESS | 10341 | 08:42:07 INFO - PROCESS | 10341 | __start_tp_report 08:42:07 INFO - PROCESS | 10341 | _x_x_mozilla_page_load 08:42:07 INFO - PROCESS | 10341 | _x_x_mozilla_page_load_details 08:42:07 INFO - PROCESS | 10341 | |i|pagename|runs| 08:42:07 INFO - PROCESS | 10341 | |0;ai-astar;111;112;106;112;112;113;100;112;111;113 08:42:07 INFO - PROCESS | 10341 | |1;audio-beat-detection;174;137;159;182;145;163;164;140;193;134 08:42:07 INFO - PROCESS | 10341 | |2;audio-dft;160;162;160;162;163;161;161;161;162;161 08:42:07 INFO - PROCESS | 10341 | |3;audio-fft;77;74;114;122;74;73;76;121;105;73 08:42:07 INFO - PROCESS | 10341 | |4;audio-oscillator;93;95;143;94;94;95;145;94;95;144 08:42:07 INFO - PROCESS | 10341 | |5;imaging-gaussian-blur;118;117;117;117;117;117;117;117;117;117 08:42:07 INFO - PROCESS | 10341 | |6;imaging-darkroom;146;146;147;146;146;147;148;148;146;147 08:42:07 INFO - PROCESS | 10341 | |7;imaging-desaturate;95;96;95;95;95;96;95;96;96;95 08:42:07 INFO - PROCESS | 10341 | |8;json-parse-financial;65;67;65;65;65;65;65;90;63;62 08:42:07 INFO - PROCESS | 10341 | |9;json-stringify-tinderbox;64;65;65;65;65;65;72;65;65;64 08:42:07 INFO - PROCESS | 10341 | |10;stanford-crypto-aes;85;85;83;85;91;86;85;86;84;84 08:42:07 INFO - PROCESS | 10341 | |11;stanford-crypto-ccm;139;138;140;137;145;138;141;142;168;137 08:42:07 INFO - PROCESS | 10341 | |12;stanford-crypto-pbkdf2;173;177;173;169;175;174;172;172;180;171 08:42:07 INFO - PROCESS | 10341 | |13;stanford-crypto-sha256-iterative;73;74;74;70;70;71;71;72;72;70 08:42:07 INFO - PROCESS | 10341 | __end_tp_report 08:42:07 INFO - PROCESS | 10341 | __start_cc_report 08:42:07 INFO - PROCESS | 10341 | _x_x_mozilla_cycle_collect,1887 08:42:07 INFO - PROCESS | 10341 | __end_cc_report 08:42:07 INFO - PROCESS | 10341 | __startTimestamp1460648527880__endTimestamp 08:42:07 INFO - PROCESS | 10341 | 08:42:07 INFO - PROCESS | 10341 | ------- Summary: start ------- 08:42:07 INFO - PROCESS | 10341 | Number of tests: 14 08:42:07 INFO - PROCESS | 10341 | 08:42:07 INFO - PROCESS | 10341 | [#0] ai-astar Cycles:10 Average:110.20 Median:112.00 stddev:4.10 (3.7%) stddev-sans-first:4.34 08:42:07 INFO - PROCESS | 10341 | Values: 111.0 112.0 106.0 112.0 112.0 113.0 100.0 112.0 111.0 113.0 08:42:07 INFO - PROCESS | 10341 | 08:42:07 INFO - PROCESS | 10341 | [#1] audio-beat-detection Cycles:10 Average:159.10 Median:163.50 stddev:20.05 (12.3%) stddev-sans-first:20.53 08:42:07 INFO - PROCESS | 10341 | Values: 174.0 137.0 159.0 182.0 145.0 163.0 164.0 140.0 193.0 134.0 08:42:07 INFO - PROCESS | 10341 | 08:42:07 INFO - PROCESS | 10341 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:0.95 (0.6%) stddev-sans-first:0.88 08:42:07 INFO - PROCESS | 10341 | Values: 160.0 162.0 160.0 162.0 163.0 161.0 161.0 161.0 162.0 161.0 08:42:07 INFO - PROCESS | 10341 | 08:42:07 INFO - PROCESS | 10341 | [#3] audio-fft Cycles:10 Average:90.90 Median:73.50 stddev:21.69 (29.5%) stddev-sans-first:22.41 08:42:07 INFO - PROCESS | 10341 | Values: 77.0 74.0 114.0 122.0 74.0 73.0 76.0 121.0 105.0 73.0 08:42:07 INFO - PROCESS | 10341 | 08:42:07 INFO - PROCESS | 10341 | [#4] audio-oscillator Cycles:10 Average:109.20 Median:94.00 stddev:24.03 (25.6%) stddev-sans-first:24.76 08:42:07 INFO - PROCESS | 10341 | Values: 93.0 95.0 143.0 94.0 94.0 95.0 145.0 94.0 95.0 144.0 08:42:07 INFO - PROCESS | 10341 | 08:42:07 INFO - PROCESS | 10341 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 08:42:07 INFO - PROCESS | 10341 | Values: 118.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 08:42:07 INFO - PROCESS | 10341 | 08:42:07 INFO - PROCESS | 10341 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.83 08:42:07 INFO - PROCESS | 10341 | Values: 146.0 146.0 147.0 146.0 146.0 147.0 148.0 148.0 146.0 147.0 08:42:07 INFO - PROCESS | 10341 | 08:42:07 INFO - PROCESS | 10341 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 08:42:07 INFO - PROCESS | 10341 | Values: 95.0 96.0 95.0 95.0 95.0 96.0 95.0 96.0 96.0 95.0 08:42:07 INFO - PROCESS | 10341 | 08:42:07 INFO - PROCESS | 10341 | [#8] json-parse-financial Cycles:10 Average:67.20 Median:65.00 stddev:8.12 (12.5%) stddev-sans-first:8.57 08:42:07 INFO - PROCESS | 10341 | Values: 65.0 67.0 65.0 65.0 65.0 65.0 65.0 90.0 63.0 62.0 08:42:07 INFO - PROCESS | 10341 | 08:42:07 INFO - PROCESS | 10341 | [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:65.00 stddev:2.32 (3.6%) stddev-sans-first:2.40 08:42:07 INFO - PROCESS | 10341 | Values: 64.0 65.0 65.0 65.0 65.0 65.0 72.0 65.0 65.0 64.0 08:42:07 INFO - PROCESS | 10341 | 08:42:07 INFO - PROCESS | 10341 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:85.00 stddev:2.17 (2.6%) stddev-sans-first:2.30 08:42:07 INFO - PROCESS | 10341 | Values: 85.0 85.0 83.0 85.0 91.0 86.0 85.0 86.0 84.0 84.0 08:42:07 INFO - PROCESS | 10341 | 08:42:07 INFO - PROCESS | 10341 | [#11] stanford-crypto-ccm Cycles:10 Average:142.50 Median:140.50 stddev:9.30 (6.6%) stddev-sans-first:9.78 08:42:07 INFO - PROCESS | 10341 | Values: 139.0 138.0 140.0 137.0 145.0 138.0 141.0 142.0 168.0 137.0 08:42:07 INFO - PROCESS | 10341 | 08:42:07 INFO - PROCESS | 10341 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.60 Median:173.50 stddev:3.13 (1.8%) stddev-sans-first:3.32 08:42:07 INFO - PROCESS | 10341 | Values: 173.0 177.0 173.0 169.0 175.0 174.0 172.0 172.0 180.0 171.0 08:42:07 INFO - PROCESS | 10341 | 08:42:07 INFO - PROCESS | 10341 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.70 Median:72.00 stddev:1.57 (2.2%) stddev-sans-first:1.59 08:42:07 INFO - PROCESS | 10341 | Values: 73.0 74.0 74.0 70.0 70.0 71.0 71.0 72.0 72.0 70.0 08:42:07 INFO - PROCESS | 10341 | -------- Summary: end -------- 08:42:07 INFO - PROCESS | 10341 | 08:42:08 INFO - TEST-INFO | 10341: exit 0 08:42:08 INFO - TEST-OK | kraken | took 63702ms 08:42:08 INFO - SUITE-END | took 1182s 08:42:09 INFO - Completed test suite (00:19:42) 08:42:09 INFO - javascript benchmark 08:42:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2647.2720001999455, 2695.5417579011564, 2704.0670968515856, 2724.577690457977, 2729.6587926509187, 4655.045715628296, 4663.720176789395, 4698.647601429893, 4720.197566413709, 4760.33355330254, 4695.389599352088, 4711.764411779414, 4731.408573928259, 4801.711897286165, 4826.348442960208, 4259.297215959363, 4306.267934451135, 4368.1918845013615, 4389.0, 4493.3484644726495, 4408.052268762215, 4445.110977804436, 4456.286994080948, 4468.3074123510905, 4492.2812350024005, 4251.893702657428, 4275.529691733938, 4319.935200971988, 4325.567443255681, 4351.673624478177, 4360.433143691332, 4364.061726728769, 4389.846355377546, 4395.604395604379, 4430.246858034142, 4320.891977700551, 4372.825086996516, 4379.277419225824, 4424.292113261863, 4427.734335939822, 4380.167768124078, 4541.750203738826, 4585.587297143273, 4620.838270660511, 4632.837850675211, 5057.924131138036, 5062.392512898439, 5066.822661206877, 5067.0, 5079.619028572872, 5080.187170052774, 5098.082345177866, 5100.209467532539, 5110.514501122388, 5115.386153661584, 4535.206338890681, 4650.162970665313, 4712.104700106968, 4733.786979585927, 4735.550122738335, 5126.487351264844, 5130.1535246684625, 5142.794288228429, 5150.40770311419, 5166.767495462713, 4937.580305673986, 4943.950560494421, 4948.579370753454, 4959.355283813154, 5002.199648056294, 4886.3403440535785, 4964.8510544682995, 5032.295478632995, 5066.240063990357, 5067.822626208065, 4964.90070198594, 5010.073136469765, 5013.222950442687, 5016.724080175552, 5061.493850614909, 4852.320675105488, 4983.177775667047, 5004.599632029502, 5011.649184557119, 5055.165897626924, 4077.8776636700354, 4186.832526698898, 4220.219259436953, 4261.147770445923, 4267.231898258281, 3688.797116158637, 3689.096171438015, 3693.963060369416, 3708.9072773180887, 3732.720045996561, 4279.914401711948, 4334.393184954109, 4350.216960946997, 4357.455318085239, 4384.868453946387, 5031.471695471996, 5053.393592768818, 5067.391912970467, 5090.618203634742, 5116.334876466036, 4364.738115713068, 4369.47566292047, 4370.038591509926, 4372.3878656988045, 4406.669499787528, 4433.778311084433, 4521.389612402284, 4533.274676051816, 4535.297028960516, 4573.0, 4743.501932297059, 4766.499517550607, 4771.308160316735, 4779.450363208275, 4816.927746083811, 4982.576480999156, 5017.84946451607, 5018.322526458881, 5039.218921067094, 5065.898682026265, 4621.191291523903, 4727.669063165546, 4762.499937506651, 4785.569298763128, 4803.0153818467825, 4953.380827396575, 4969.577585905238, 4987.376577927759, 4988.42633097184, 5016.573591244785, 5024.196128619404, 5048.091343558195, 5063.961887813063, 5067.822626208065, 5077.213031980049, 4756.429228492603, 4901.485344038824, 4926.655134140576, 4969.105560998911, 4977.054359671795, 4874.268859671078, 4891.804327826847, 4908.1098301575375, 4908.116539022867, 4957.677750946177, 4814.8796280093275, 4845.8061677532505, 4848.903021939612, 4850.878728031827, 4897.730624815669, 4684.461286952044, 4818.156822556109, 4866.610671146229, 4903.0193961208615, 4933.235348520985, 4691.08523837862, 4707.4821769606, 4714.104320179155, 4715.009847931836, 4716.127516409475], "value": 4623.6424260923595, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.7099908047816, 583.1515145463351, 602.5240060352319, 606.5996442348049, 611.571899670231, 32850.342993140155, 33684.663153368456, 34105.0, 34570.65429345706, 34573.481397779055, 36915.0, 37382.0, 37480.81259593705, 37527.43708844363, 37583.43624845623, 7243.203247642755, 7802.726904558327, 8012.839743205132, 8015.799605009863, 9594.616215351412, 9726.319157658967, 9905.257105717064, 9907.752306192368, 9908.504574771268, 9913.306068575203, 9820.705378838646, 9916.0, 9936.354136981074, 9947.55236014381, 9951.353162044445, 9736.561854716554, 9853.211743060538, 9863.60545578176, 9869.259805514615, 9872.35829671069, 9691.806163876754, 9807.31348805584, 9812.36219645728, 9824.557894894748, 9826.705198844045, 36345.81827090874, 36749.0, 36836.44745328822, 36843.631563684285, 36908.446373304425, 3050.6339239291206, 3081.876724931, 3096.5819614352, 3278.2623909620143, 3557.128503516655, 28444.431111377864, 29266.70733292661, 29375.2656183595, 29643.258918527208, 30205.395892082255, 3468.0465666339082, 3470.4273794823825, 3479.3215323012023, 3488.284901595167, 3563.4120370138894, 232508.0, 233038.0, 234682.0, 235183.8240808802, 236343.0, 55367.446325537036, 55378.16932746012, 55535.444645553835, 55588.0, 55694.44305556973, 58022.41977580255, 58198.4180158193, 58362.70818645965, 58557.4144258552, 58564.414355856745, 14047.367868445945, 14706.852931470763, 14725.337359818834, 14735.926320368544, 14745.336459859333, 9865.0, 9876.555555000043, 9880.851787223197, 9882.851757223647, 9890.802183956424, 18551.90724046371, 18572.164252608396, 18723.25106995705, 18755.718664220047, 18782.342618008304, 6986.16166060076, 7213.89179162313, 7216.386607138452, 7267.491275610657, 7287.526310789782, 945.6690158444627, 950.8621249918862, 974.5565767575736, 992.6995635717234, 1074.752806854428, 27569.448611027667, 27747.72252277492, 28035.579466308023, 28169.57745633817, 28300.85849570739, 994.2046362909788, 1055.8469021991768, 1077.8652668416448, 1082.86464191976, 1145.4215621111452, 13797.310134493235, 13810.447582096604, 13952.16287022782, 13988.300584970913, 14054.367553460119, 317934.0, 410023.0, 420131.0, 420361.0, 421626.0, 49683.25475117876, 50442.24336634953, 50983.49016509787, 51126.23310650343, 51161.0, 1164.4527072276016, 1235.215638069832, 1279.3858947704969, 1281.7052078022107, 1387.9867696581553, 26037.609435858856, 29219.707802921697, 29256.853715731286, 29607.85196074006, 29730.405391891607, 40362.798186008884, 41047.38428923628, 41215.175696486505, 41256.381154282106, 41273.587264128175, 235948.0, 236219.0, 238196.0, 239286.0, 239488.0, 25433.87283063573, 26382.472350552496, 26445.206643800717, 26460.470790584466, 26486.470270594866, 42441.787791060844, 42854.78572607117, 43154.56845431506, 44038.11923761571, 44174.779126104164, 34630.82684586561, 35073.473897892065, 35853.64146358607, 35856.0, 35967.28065438624, 35626.0, 36233.63766362303, 36328.63671363253, 36412.81793591015, 36662.8166859164, 35976.0, 36575.26849463049, 36726.08184795402, 37021.62978370182, 37171.44242836306, 30639.693603063683, 32711.0, 32768.0, 32899.039086482335, 32934.34131317312, 24967.87516062408, 25341.239762807145, 25362.492750145262, 25412.85642146145, 25638.743612563634], "value": 17930.381833914013, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.3038288018524, 372.32980634857256, 391.723834696539, 396.50634959475457, 401.2336437404554, 15687.52937411878, 17026.233819478122, 17098.914505427485, 17126.828731712678, 17209.913950430247, 10298.279120461571, 10626.203034772403, 10844.0, 10857.077148442391, 10886.891131088687, 4652.953470465286, 4805.135075686375, 5114.28400023997, 5157.381114266274, 5223.895522089556, 4814.1334559779225, 5260.368755749316, 5265.0259701955065, 5269.8946021079555, 5283.154695248761, 5190.32525771651, 5193.766280517367, 5213.426523082458, 5228.633995620289, 5244.187150991603, 5066.873328166788, 5145.794168233266, 5164.328637277167, 5183.144781111112, 5221.843344699665, 4626.0, 4653.953460465385, 4664.953350466486, 4955.851324460236, 4962.528559786814, 19747.21011159552, 19772.604547908963, 19784.901075494676, 20038.79961200384, 20205.19179232829, 1730.679824232521, 1861.776586809578, 2007.8192962633286, 2134.509062915538, 2341.789238968484, 9669.661561845372, 10811.675649730521, 12881.325427694339, 13036.283004434752, 13710.38303276355, 1685.7302831547017, 1696.9660606787795, 1790.4807605794304, 1809.9185536650882, 1861.1624768853935, 49366.15286255163, 49423.75288123573, 54497.99999999961, 66189.0, 69362.0, 9608.231341492663, 9738.036467871634, 9824.705258842247, 9930.453825039693, 10003.299769016245, 11900.64298071042, 12843.165194262343, 13220.140690855063, 13259.469621215043, 13581.524646637321, 7197.4961752677855, 7233.45749068822, 7263.418926485869, 7310.854330339704, 7343.559386436831, 6763.6618169092335, 6855.5543889647015, 6999.405050570656, 7078.079849619619, 7094.7162113515915, 4132.834686612562, 4174.7077704561, 4185.455890734246, 4233.640140588023, 4570.520095390003, 1764.126757255167, 1788.2399980008445, 1790.6955817511055, 1803.5491127218195, 1812.3566134022233, 869.4696235296464, 879.2658130461136, 912.4479689787715, 926.129438327983, 1012.2054187462807, 16011.199440027953, 16560.254788534545, 16588.6682266354, 16865.07242101696, 17052.0, 863.7020228021322, 868.1318681318681, 897.228383590112, 899.6896070855545, 940.548536702373, 8975.596098175598, 9324.300677449219, 9396.436213827192, 9426.62293508252, 9622.47076410804, 392054.0, 392170.0, 407868.0, 410129.0, 410572.0, 76706.0, 79314.0, 79974.60012700016, 79999.0, 80956.0, 934.5841100710255, 940.8071345374182, 954.1079091049891, 982.1553464020936, 994.721477986165, 14414.567562972708, 14444.0, 14636.195009274592, 14667.779983300046, 14851.628709282355, 32199.678003220604, 33321.0, 33590.49614255837, 33689.494657580646, 34245.82877085599, 48228.0, 48586.02827943351, 48628.75685621549, 48788.0, 48899.75550122369, 7309.305615966475, 7483.513571617827, 7535.54786712799, 7537.660805263886, 7544.0, 10892.18308626872, 10975.451227438756, 11183.552657893919, 11402.20184587071, 11518.0, 9486.95256523713, 9540.427574345562, 9724.0, 9983.301168918397, 10169.084782369622, 9596.9040309596, 9868.851967220355, 9873.111419972238, 9887.901120988698, 9911.30620856562, 9717.465539395118, 9983.650572229937, 10011.0, 10024.24818138657, 10322.483875806029, 7381.077365329334, 7438.814029649302, 7441.590712510864, 7480.364169045474, 7649.9617501912135, 7467.103947526114, 9441.433513988908, 9834.01659834011, 9881.555330010311, 10158.985192458475], "value": 7979.064158384752, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1304.6216597186803, 1411.9788203176954, 1468.016428992575, 1573.819010813756, 1791.4625612316302, 7512.0, 7830.56931868747, 7833.5299882006975, 7850.960745196273, 7870.252326029025, 7689.9231007689905, 7818.569978651172, 7843.490173138742, 7861.56761378124, 7867.8426431471335, 1879.6710575649274, 2074.077035719102, 2090.968635470469, 2183.355910006544, 2259.062489067035, 2213.391317387715, 2229.375774783063, 2232.598132336179, 2234.307364716935, 2236.0049777848863, 2109.335559298816, 2138.3905586907736, 2144.1209104267255, 2144.1423430627797, 2145.5816115857415, 1874.7562816833793, 2170.359743875553, 2228.0864845413466, 2237.8433509654333, 2239.9776002239932, 2155.4072630026712, 2160.751513575943, 2174.945626359338, 2175.086463685256, 2195.1548653768414, 7766.728164514215, 7772.922270777333, 7809.648565814552, 7832.138464768871, 7873.291403773631, 4519.5480451954545, 4669.859904202879, 4680.321353403738, 4696.929546056812, 4713.151632706112, 2985.4327677741157, 2998.235449960246, 3049.9085027449214, 3053.2977415194628, 3059.938801223985, 984.7045886234101, 993.696922438656, 1018.8981101889751, 1019.9337043092175, 1028.547439126782, 10974.670759877217, 11012.39431831249, 11015.669529914116, 11032.944835275852, 11034.668959931216, 4173.207090652766, 4282.657387409, 4466.1067786442845, 4501.0547784964865, 4527.162474942146, 8585.957070214608, 8651.610677519528, 8711.433756805787, 8724.78188045304, 8728.432651877607, 3914.1584559319313, 4721.787519561628, 4745.525447455296, 4753.001869607421, 4755.310479980383, 4229.365595160751, 4317.0934103838545, 4321.308590625547, 4322.308430651081, 4352.673549483801, 3450.7929524228625, 3489.65103489649, 3545.982270088685, 3548.698360639323, 3619.4570814377525, 1066.0991462214417, 1087.0705546757408, 1094.9069329107115, 1098.3025778630627, 1107.534835369147, 826.7726375246855, 861.9224269815621, 924.8150369926042, 935.7941252924346, 940.6425558287943, 5510.724463776875, 5669.064604340238, 5761.308642962787, 5765.077587585966, 5810.912836307459, 897.4166791585521, 898.4788822482944, 910.1762904571374, 914.4284821986258, 935.1069728409353, 3630.219502806909, 3792.2605092007348, 3977.125032492847, 3977.482927219443, 3983.50206224222, 9618.182454491307, 10023.198144148451, 10098.697039088838, 10132.240081993732, 10157.746056348502, 9899.60401583943, 9937.850932236022, 10004.399736015717, 10099.343542669703, 10135.543900524493, 7184.173820010766, 7267.672954717156, 7316.9390438386135, 7340.11918569775, 7392.741254056083, 5383.1117865553315, 5507.779688812403, 5562.666240025612, 5567.4432556744005, 5580.330360356783, 9077.90922090797, 9268.675596354095, 9300.209482193819, 9312.0, 9315.72052838416, 9056.456612603264, 9243.121903419164, 9463.0, 9501.192398645917, 9516.619335226791, 5807.651540907559, 5993.580449368676, 6002.639841609517, 6497.252815926229, 6641.634710090992, 6626.237982632059, 7403.296686814744, 7610.961945190239, 7638.656260468181, 7662.73180438682, 6670.9332906670315, 6807.795766127024, 6808.148981377328, 6917.93082069193, 6935.826604334932, 6533.281339052605, 6584.76953306632, 6596.8350791230605, 6633.270340262664, 6795.014722865256, 6331.145295385249, 6367.044943258548, 6384.489240860813, 6394.616323020634, 6431.131797207504, 4708.0, 4849.854504364875, 4956.306117143531, 4980.203167493184, 4990.725510096834, 4886.828960986349, 4964.553190212898, 4967.850964471072, 5054.2671312660195, 5083.085044691991], "value": 4214.8823709638555, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.7672998710941, 319.2481705583351, 321.7699344968347, 325.941330560499, 326.82678180564295, 5065.0, 5118.48815118488, 5133.409657889344, 5134.974325128378, 5174.741262936857, 5066.037452883958, 5076.111680455915, 5076.898462030757, 5080.618953578487, 5085.720285384303, 3808.5048943637357, 3842.559040359865, 4019.9598004019876, 4026.094128821021, 4028.7179897407195, 3995.9600403996023, 4013.1371755072655, 4022.9798851005703, 4024.798760062, 4046.3525835866267, 3764.8305826237884, 3993.9201215975663, 4000.039990402297, 4003.1593365393155, 4007.458993035932, 3841.7310788244836, 3920.1963597462595, 3948.5261768587666, 3953.683705303569, 3971.801409929492, 3529.9647003529894, 3542.0967653248513, 3549.2901419715904, 3550.5739311282555, 3557.6620221078956, 4924.507549245047, 4930.778114984834, 4936.086823937583, 4954.950450495521, 4956.107900577895, 4329.523752387235, 4549.181147393468, 4550.840720574764, 4582.518835522255, 4611.26219804833, 5308.787648494055, 5316.946830531722, 5327.760250788724, 5338.62629615927, 5342.652727572696, 3780.319542482352, 3783.0, 3790.2608991246716, 3793.1655035892336, 3804.8478060877533, 5521.723913804334, 5557.249771280865, 5560.4161563036105, 5577.69322687252, 5578.967890940148, 3852.788096654655, 3876.3604005339366, 3878.204967981557, 3885.1646895917515, 3887.125396785757, 3914.3345631242187, 3928.46965659638, 3935.252302062599, 3940.4877365942243, 3953.584873588289, 4286.207051695446, 4538.704984176018, 4543.704659197208, 4550.977245113753, 4553.954460455353, 5385.407605163429, 5408.781774843961, 5415.6479828811, 5416.8104116355735, 5423.322084739408, 1360.6122255157234, 1375.690469644342, 1380.5996261084374, 1380.9573771802225, 1381.1920026784444, 874.6370256343673, 909.6406919266852, 925.7824411263348, 928.122923836981, 942.8444306689456, 4688.296755486705, 4688.742119183409, 4707.505711900201, 4718.811247550059, 4719.079779443045, 5483.314585676791, 5509.228707980886, 5517.282753242133, 5530.419305972895, 5535.889282214333, 4555.293929440942, 4748.453927798348, 4749.4063242094735, 4754.78603462845, 4759.50025247351, 2947.292649764041, 2963.6888126746812, 2967.569702393184, 2974.672785993539, 2984.4180384825186, 5244.0, 5250.238715386324, 5251.0, 5257.553107985864, 5260.605454590845, 5530.0, 5683.175939488751, 5702.6293290935955, 5714.514266287329, 5727.799527016535, 5197.194434862602, 5247.527722504993, 5249.186376111708, 5261.447548007481, 5272.604554658416, 5421.159720243369, 5564.721763911869, 5572.804951826666, 5587.804426845203, 5600.803971860965, 5451.781928722965, 5479.068558345011, 5489.807856724996, 5492.2424824055915, 5493.615446918678, 5216.713080780593, 5240.135377662643, 5240.825057601053, 5245.868853278698, 5247.137266270572, 3806.733528652968, 3882.087709388235, 3900.9609903901733, 3901.2197560488585, 3921.9607803921594, 5521.309836270466, 5529.972350138223, 5534.418886016911, 5538.252335934759, 5541.33503979525, 5288.656237344714, 5339.225812257123, 5372.1941708744, 5392.11521835816, 5398.568114550905, 5272.578193744414, 5326.6537675050995, 5350.598705097055, 5369.436209197978, 5380.058489764354, 5056.6207534434325, 5274.261603375454, 5304.575633949352, 5309.973450132725, 5317.654352467077, 5201.661891977009, 5381.946180538301, 5403.189521571796, 5404.675719456845, 5418.485243901823, 5276.445973172915, 5276.9472305278, 5280.0, 5285.894282114413, 5291.7354132294], "value": 4045.9687519102845, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [647.7214797637016, 723.7864829875186, 756.5725365168678, 773.3272053313618, 793.5873345860152, 11229.719257018578, 11313.264637798537, 11338.60314888979, 11359.261647992886, 11773.470193841276, 12458.750824983495, 12627.36863156843, 12647.241165530051, 12657.114002019862, 12668.80996785049, 807.9313258373031, 808.454293351988, 814.4258297899967, 816.0859836982559, 816.1348970091692, 642.1780121444558, 775.7246177606953, 809.4536188073057, 812.2689579378577, 812.6383759227147, 846.0524212881581, 846.4794151596785, 847.3814115695546, 848.3679658654311, 848.8047749017729, 664.1498881431775, 840.9117042710519, 841.0286119531951, 841.478283464253, 841.7979684875647, 601.9518438524907, 618.3847072163181, 619.2414292491707, 619.5260625621403, 619.7087368936593, 11743.177977541576, 11828.763424731456, 11835.526578936831, 11835.88164118365, 11864.881351186465, 11954.0, 12189.329586872718, 12277.877221227764, 12544.560940367135, 12802.74394512114, 8987.14622110905, 9099.863502047474, 9106.544672766335, 9128.269738420977, 9225.308101892386, 3246.318273162639, 3272.149241197282, 3305.6694330566993, 3315.336932613463, 3405.880794172217, 46263.53736462626, 46279.30581041287, 46295.76852115718, 46309.53690463086, 46385.768071160106, 9464.716058518256, 9859.457729824786, 9955.55200016001, 10196.490175491344, 10203.642872499428, 17188.22652980594, 17204.827951720574, 17336.65326693459, 17731.29074837018, 18182.18180181895, 6841.897371539431, 6918.377346038881, 7053.365197132282, 7061.1173603299585, 7090.680919358641, 3621.6740493355196, 3626.38351480249, 3660.4692319613505, 3668.706503479715, 3733.5893051764283, 2921.6347956505438, 3069.171323742577, 3072.738817200563, 3077.1845460952864, 3077.6460707018978, 542.0216509200931, 544.5099410530554, 550.6921062476619, 553.9446055394428, 557.8382269141985, 575.7409165875373, 604.7943699142224, 611.0711718188329, 612.295859761278, 612.7947137708828, 7303.0, 7452.403807695371, 7517.624118794039, 7891.881621775678, 7925.762227133196, 512.9563987061142, 586.2183937217928, 646.612032780328, 648.4423395879539, 661.206552137437, 3539.734519911017, 3769.679577235911, 3782.319182547113, 3806.5812760596314, 3810.466534685146, 52160.0, 52872.47127528753, 52902.0, 52922.47077529175, 53155.0, 45182.54817451849, 46687.29969050467, 47011.29483057757, 47463.99999999931, 48301.275480867815, 41763.7911810439, 42774.57225427706, 42866.571334286884, 43184.56815431868, 43730.125397492506, 7493.213212612815, 7513.924860751323, 7539.585322807079, 7684.385249179941, 7843.137254901842, 25668.0, 25697.547711163552, 26680.8665956669, 27488.45023099567, 27618.861905690344, 31479.21301967469, 34402.0, 34912.825435872655, 35160.94517164489, 35784.0, 10295.53670084833, 10357.585696572052, 10622.468876556295, 10677.679669609925, 10700.89299106999, 11164.0, 11372.43137843088, 11385.203035787416, 12142.696432589257, 12270.938645306716, 10065.647702330383, 10366.222533309881, 10391.37651740898, 10610.363378197333, 10672.62645807393, 10369.792604148026, 10829.891701082888, 10834.458277085956, 10994.175436842108, 11254.83117753218, 10358.430286334324, 10513.474326283807, 10899.455027248765, 10993.835092473779, 11192.608258710907, 9355.298352623444, 9652.327344118834, 9669.129778319984, 9815.11663950248, 9923.851142232728, 8660.523671198145, 8946.284297256334, 9327.300452465957, 9365.297602679962, 9460.526973651153], "value": 5861.3061194110705, "unit": "score"}], "name": "dromaeo_css", "value": 6359.103575057138, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 106.0, 112.0, 112.0, 113.0, 100.0, 112.0, 111.0, 113.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 137.0, 159.0, 182.0, 145.0, 163.0, 164.0, 140.0, 193.0, 134.0], "value": 159.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 160.0, 162.0, 163.0, 161.0, 161.0, 161.0, 162.0, 161.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 74.0, 114.0, 122.0, 74.0, 73.0, 76.0, 121.0, 105.0, 73.0], "value": 90.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 95.0, 143.0, 94.0, 94.0, 95.0, 145.0, 94.0, 95.0, 144.0], "value": 109.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.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": [146.0, 146.0, 147.0, 146.0, 146.0, 147.0, 148.0, 148.0, 146.0, 147.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 65.0, 65.0, 65.0, 65.0, 65.0, 90.0, 63.0, 62.0], "value": 67.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 65.0, 65.0, 65.0, 72.0, 65.0, 65.0, 64.0], "value": 65.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 83.0, 85.0, 91.0, 86.0, 85.0, 86.0, 84.0, 84.0], "value": 85.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 138.0, 140.0, 137.0, 145.0, 138.0, 141.0, 142.0, 168.0, 137.0], "value": 142.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 177.0, 173.0, 169.0, 175.0, 174.0, 172.0, 172.0, 180.0, 171.0], "value": 173.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 74.0, 70.0, 70.0, 71.0, 71.0, 72.0, 72.0, 70.0], "value": 71.7, "unit": "score"}], "name": "kraken", "value": 1595.8, "alertThreshold": 2.0}]} 08:42:09 INFO - Return code: 0 08:42:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:42:09 ERROR - # TBPL SUCCESS # 08:42:09 INFO - Running post-action listener: _resource_record_post_action 08:42:09 INFO - Running post-run listener: _resource_record_post_run 08:42:10 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 516997120; Read time: 16; Write time: 518308 08:42:10 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 211742720; Read time: 0; Write time: 240260 08:42:10 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 283164672; Read time: 16; Write time: 274932 08:42:10 INFO - Running post-run listener: _upload_blobber_files 08:42:10 INFO - Blob upload gear active. 08:42:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:42:10 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:42:10 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:42:10 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:42:10 INFO - (blobuploader) - INFO - Open directory for files ... 08:42:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:42:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:42:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:42:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:42:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:42:11 INFO - (blobuploader) - INFO - Done attempting. 08:42:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:42:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:42:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:42:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:42:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:42:12 INFO - (blobuploader) - INFO - Done attempting. 08:42:12 INFO - (blobuploader) - INFO - Iteration through files over. 08:42:12 INFO - Return code: 0 08:42:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:42:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:42:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7b8a85b3def9f9bde3370710a7017b6a660cec315d87874547f434a95052891661d58093cffbc1b3b81dd15a512483a3cc82b1e25815bf8a80d2fd76d93d5fbe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/62bb701100c0da58125b2b169e666e4bc3c99e1031d9fb85b1b7caaeccedb19e21bb70251eabac57f6e91b441de4ab6d0bd82e7c3b7cc7f6a71480065230032d"} 08:42:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:42:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:42:12 INFO - Contents: 08:42:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7b8a85b3def9f9bde3370710a7017b6a660cec315d87874547f434a95052891661d58093cffbc1b3b81dd15a512483a3cc82b1e25815bf8a80d2fd76d93d5fbe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/62bb701100c0da58125b2b169e666e4bc3c99e1031d9fb85b1b7caaeccedb19e21bb70251eabac57f6e91b441de4ab6d0bd82e7c3b7cc7f6a71480065230032d"} 08:42:12 INFO - Running post-run listener: copy_logs_to_upload_dir 08:42:12 INFO - Copying logs to upload dir... 08:42:12 INFO - mkdir: /builds/slave/test/build/upload/logs 08:42:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.560223 ========= master_lag: 0.24 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-04-14 08:42:11.509773) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 08:42:11.512980) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1460645738.372081-924134935 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7b8a85b3def9f9bde3370710a7017b6a660cec315d87874547f434a95052891661d58093cffbc1b3b81dd15a512483a3cc82b1e25815bf8a80d2fd76d93d5fbe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/62bb701100c0da58125b2b169e666e4bc3c99e1031d9fb85b1b7caaeccedb19e21bb70251eabac57f6e91b441de4ab6d0bd82e7c3b7cc7f6a71480065230032d"} build_url:https://queue.taskcluster.net/v1/task/dQ2Ijhe7Sl2k-9MiK2saew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011247 build_url: 'https://queue.taskcluster.net/v1/task/dQ2Ijhe7Sl2k-9MiK2saew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7b8a85b3def9f9bde3370710a7017b6a660cec315d87874547f434a95052891661d58093cffbc1b3b81dd15a512483a3cc82b1e25815bf8a80d2fd76d93d5fbe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/62bb701100c0da58125b2b169e666e4bc3c99e1031d9fb85b1b7caaeccedb19e21bb70251eabac57f6e91b441de4ab6d0bd82e7c3b7cc7f6a71480065230032d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 08:42:11.540328) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 08:42:11.540691) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1460645738.372081-924134935 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004524 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 08:42:11.627427) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 08:42:11.628039) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 08:42:11.628389) ========= ========= Total master_lag: 0.41 =========