builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-021 starttime: 1460655721.79 results: success (0) buildid: 20160414075542 builduid: 16bdcdf37a1348ba8ddc3ca41c5b5061 revision: 949d0760be73d73ee1fa7dab0b5a7102f169ece3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 10:42:01.791806) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 10:42:01.792280) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 10:42:01.792593) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 10:42:01.806805) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 10:42:01.807190) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1460655721.354275-1231228638 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-14 10:42:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 29.9M=0s 2016-04-14 10:42:02 (29.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.157631 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 10:42:01.976883) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 10:42:01.977239) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1460655721.354275-1231228638 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016373 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 10:42:02.027430) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-14 10:42:02.027790) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 949d0760be73d73ee1fa7dab0b5a7102f169ece3 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 949d0760be73d73ee1fa7dab0b5a7102f169ece3 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1460655721.354275-1231228638 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-14 10:42:02,346 truncating revision to first 12 chars 2016-04-14 10:42:02,346 Setting DEBUG logging. 2016-04-14 10:42:02,346 attempt 1/10 2016-04-14 10:42:02,346 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/949d0760be73?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-14 10:42:03,408 unpacking tar archive at: mozilla-aurora-949d0760be73/testing/mozharness/ program finished with exit code 0 elapsedTime=1.388521 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-14 10:42:03.428553) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 10:42:03.428876) ========= script_repo_revision: 949d0760be73d73ee1fa7dab0b5a7102f169ece3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 10:42:03.429299) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 10:42:03.429579) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 10:42:03.441454) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-04-14 10:42:03.441744) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1460655721.354275-1231228638 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:42:03 INFO - MultiFileLogger online at 20160414 10:42:03 in /builds/slave/test 10:42:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 10:42:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:42:03 INFO - {'append_to_log': False, 10:42:03 INFO - 'base_work_dir': '/builds/slave/test', 10:42:03 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 10:42:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:42:03 INFO - 'branch': 'Mozilla-Aurora', 10:42:03 INFO - 'buildbot_json_path': 'buildprops.json', 10:42:03 INFO - 'config_files': ('talos/linux_config.py',), 10:42:03 INFO - 'default_actions': ('clobber', 10:42:03 INFO - 'read-buildbot-config', 10:42:03 INFO - 'download-and-extract', 10:42:03 INFO - 'populate-webroot', 10:42:03 INFO - 'create-virtualenv', 10:42:03 INFO - 'install', 10:42:03 INFO - 'run-tests'), 10:42:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:42:03 INFO - 'download_minidump_stackwalk': True, 10:42:03 INFO - 'download_symbols': 'ondemand', 10:42:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:42:03 INFO - 'tooltool.py': '/tools/tooltool.py', 10:42:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:42:03 INFO - '/tools/misc-python/virtualenv.py')}, 10:42:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:42:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:42:03 INFO - 'installer_path': 'installer.exe', 10:42:03 INFO - 'log_level': 'info', 10:42:03 INFO - 'log_name': 'talos', 10:42:03 INFO - 'log_to_console': True, 10:42:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:42:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:42:03 INFO - 'opt_config_files': (), 10:42:03 INFO - 'pip_index': False, 10:42:03 INFO - 'sps_profile': False, 10:42:03 INFO - 'sps_profile_interval': 0, 10:42:03 INFO - 'suite': 'dromaeojs', 10:42:03 INFO - 'system_bits': '32', 10:42:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:42:03 INFO - 'title': 'talos-linux64-ix-021', 10:42:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:42:03 INFO - 'use_talos_json': True, 10:42:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:42:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:42:03 INFO - 'work_dir': 'build'} 10:42:03 INFO - ##### 10:42:03 INFO - ##### Running clobber step. 10:42:03 INFO - ##### 10:42:03 INFO - Running pre-action listener: _resource_record_pre_action 10:42:03 INFO - Running main action method: clobber 10:42:03 INFO - rmtree: /builds/slave/test/build 10:42:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:42:04 INFO - Running post-action listener: _resource_record_post_action 10:42:04 INFO - ##### 10:42:04 INFO - ##### Running read-buildbot-config step. 10:42:04 INFO - ##### 10:42:04 INFO - Running pre-action listener: _resource_record_pre_action 10:42:04 INFO - Running main action method: read_buildbot_config 10:42:04 INFO - Using buildbot properties: 10:42:04 INFO - { 10:42:04 INFO - "project": "", 10:42:04 INFO - "product": "firefox", 10:42:04 INFO - "script_repo_revision": "production", 10:42:04 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 10:42:04 INFO - "repository": "", 10:42:04 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 10:42:04 INFO - "buildid": "20160414075542", 10:42:04 INFO - "pgo_build": "True", 10:42:04 INFO - "basedir": "/builds/slave/test", 10:42:04 INFO - "buildnumber": 169, 10:42:04 INFO - "slavename": "talos-linux64-ix-021", 10:42:04 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:42:04 INFO - "platform": "ubuntu64_hw", 10:42:04 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 10:42:04 INFO - "branch": "mozilla-aurora", 10:42:04 INFO - "repo_path": "releases/mozilla-aurora", 10:42:04 INFO - "revision": "949d0760be73d73ee1fa7dab0b5a7102f169ece3", 10:42:04 INFO - "stage_platform": "linux64-pgo", 10:42:04 INFO - "builduid": "16bdcdf37a1348ba8ddc3ca41c5b5061", 10:42:04 INFO - "slavebuilddir": "test" 10:42:04 INFO - } 10:42:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/RwmgRKunR7qEQJ-LSeMHLg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 10:42:04 INFO - Running post-action listener: _resource_record_post_action 10:42:04 INFO - ##### 10:42:04 INFO - ##### Running download-and-extract step. 10:42:04 INFO - ##### 10:42:04 INFO - Running pre-action listener: _resource_record_pre_action 10:42:04 INFO - Running main action method: download_and_extract 10:42:04 INFO - mkdir: /builds/slave/test/build/tests 10:42:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:42:04 INFO - https://queue.taskcluster.net/v1/task/RwmgRKunR7qEQJ-LSeMHLg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:42:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RwmgRKunR7qEQJ-LSeMHLg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 10:42:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RwmgRKunR7qEQJ-LSeMHLg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 10:42:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RwmgRKunR7qEQJ-LSeMHLg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 10:42:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RwmgRKunR7qEQJ-LSeMHLg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:42:05 INFO - Downloaded 1448 bytes. 10:42:05 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 10:42:05 INFO - Using the following test package requirements: 10:42:05 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 10:42:05 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 10:42:05 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 10:42:05 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 10:42:05 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 10:42:05 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 10:42:05 INFO - u'jsshell-linux-x86_64.zip'], 10:42:05 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 10:42:05 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 10:42:05 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 10:42:05 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 10:42:05 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 10:42:05 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 10:42:05 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 10:42:05 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 10:42:05 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 10:42:05 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 10:42:05 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 10:42:05 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 10:42:05 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:42: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')]} 10:42:05 INFO - https://queue.taskcluster.net/v1/task/RwmgRKunR7qEQJ-LSeMHLg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:42:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RwmgRKunR7qEQJ-LSeMHLg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 10:42:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RwmgRKunR7qEQJ-LSeMHLg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 10:42:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RwmgRKunR7qEQJ-LSeMHLg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 10:42:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RwmgRKunR7qEQJ-LSeMHLg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:42:06 INFO - Downloaded 23352235 bytes. 10:42:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:42:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:42:08 INFO - Return code: 0 10:42:08 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:42:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:42:08 INFO - https://queue.taskcluster.net/v1/task/RwmgRKunR7qEQJ-LSeMHLg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:42:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RwmgRKunR7qEQJ-LSeMHLg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 10:42:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RwmgRKunR7qEQJ-LSeMHLg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 10:42:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RwmgRKunR7qEQJ-LSeMHLg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 10:42:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RwmgRKunR7qEQJ-LSeMHLg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:42:09 INFO - Downloaded 23352235 bytes. 10:42:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:42:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:42:10 INFO - Return code: 0 10:42:10 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')]} 10:42:10 INFO - https://queue.taskcluster.net/v1/task/RwmgRKunR7qEQJ-LSeMHLg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:42:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RwmgRKunR7qEQJ-LSeMHLg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 10:42:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RwmgRKunR7qEQJ-LSeMHLg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 10:42:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RwmgRKunR7qEQJ-LSeMHLg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 10:42:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RwmgRKunR7qEQJ-LSeMHLg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:42:11 INFO - Downloaded 10845168 bytes. 10:42:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:42:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:42:11 INFO - Return code: 0 10:42:11 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')]} 10:42:11 INFO - https://queue.taskcluster.net/v1/task/RwmgRKunR7qEQJ-LSeMHLg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:42:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RwmgRKunR7qEQJ-LSeMHLg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 10:42:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RwmgRKunR7qEQJ-LSeMHLg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 10:42:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RwmgRKunR7qEQJ-LSeMHLg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 10:42:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RwmgRKunR7qEQJ-LSeMHLg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:42:14 INFO - Downloaded 60573163 bytes. 10:42:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RwmgRKunR7qEQJ-LSeMHLg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 10:42:14 INFO - mkdir: /builds/slave/test/properties 10:42:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:42:14 INFO - Writing to file /builds/slave/test/properties/build_url 10:42:14 INFO - Contents: 10:42:14 INFO - build_url:https://queue.taskcluster.net/v1/task/RwmgRKunR7qEQJ-LSeMHLg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 10:42:15 INFO - Running post-action listener: _resource_record_post_action 10:42:15 INFO - Running post-action listener: set_extra_try_arguments 10:42:15 INFO - ##### 10:42:15 INFO - ##### Running populate-webroot step. 10:42:15 INFO - ##### 10:42:15 INFO - Running pre-action listener: _resource_record_pre_action 10:42:15 INFO - Running main action method: populate_webroot 10:42:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:42:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:42:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:42:15 INFO - '--tppagecycles', 10:42:15 INFO - '7'], 10:42:15 INFO - 'tests': ['tsvgm']}}, 10:42:15 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:42:15 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:42:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:42:15 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 10:42:15 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:42:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:42:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:42:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:42:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:42:15 INFO - 'talos_options': ['--e10s'], 10:42:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:42:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:42:15 INFO - 'tests': ['damp', 'tps']}, 10:42:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:42:15 INFO - 'talos_options': ['--e10s'], 10:42:15 INFO - 'tests': ['damp', 'tps']}, 10:42:15 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:42:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:42:15 INFO - 'other': {'tests': ['a11yr', 10:42:15 INFO - 'ts_paint', 10:42:15 INFO - 'tpaint', 10:42:15 INFO - 'sessionrestore', 10:42:15 INFO - 'sessionrestore_no_auto_restore', 10:42:15 INFO - 'tabpaint']}, 10:42:15 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:42:15 INFO - 'tests': ['a11yr', 10:42:15 INFO - 'ts_paint', 10:42:15 INFO - 'tpaint', 10:42:15 INFO - 'sessionrestore', 10:42:15 INFO - 'sessionrestore_no_auto_restore', 10:42:15 INFO - 'tabpaint']}, 10:42:15 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:42:15 INFO - 'tests': ['a11yr', 10:42:15 INFO - 'ts_paint', 10:42:15 INFO - 'tpaint', 10:42:15 INFO - 'sessionrestore', 10:42:15 INFO - 'sessionrestore_no_auto_restore', 10:42:15 INFO - 'tabpaint']}, 10:42:15 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:42:15 INFO - 'tests': ['a11yr', 10:42:15 INFO - 'ts_paint', 10:42:15 INFO - 'tpaint', 10:42:15 INFO - 'sessionrestore', 10:42:15 INFO - 'sessionrestore_no_auto_restore', 10:42:15 INFO - 'tabpaint']}, 10:42:15 INFO - 'other_l64': {'tests': ['a11yr', 10:42:15 INFO - 'ts_paint', 10:42:15 INFO - 'tpaint', 10:42:15 INFO - 'sessionrestore', 10:42:15 INFO - 'sessionrestore_no_auto_restore', 10:42:15 INFO - 'tabpaint']}, 10:42:15 INFO - 'other_nol64': {'tests': ['a11yr', 10:42:15 INFO - 'ts_paint', 10:42:15 INFO - 'tpaint', 10:42:15 INFO - 'sessionrestore', 10:42:15 INFO - 'sessionrestore_no_auto_restore', 10:42:15 INFO - 'tabpaint']}, 10:42:15 INFO - 'svgr': {'tests': ['tsvgx', 10:42:15 INFO - 'tsvgr_opacity', 10:42:15 INFO - 'tart', 10:42:15 INFO - 'tscrollx', 10:42:15 INFO - 'cart']}, 10:42:15 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:42:15 INFO - 'tests': ['tsvgx', 10:42:15 INFO - 'tsvgr_opacity', 10:42:15 INFO - 'tart', 10:42:15 INFO - 'tscrollx', 10:42:15 INFO - 'cart']}, 10:42:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:42:15 INFO - 'tests': ['tp5o']}, 10:42:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:42:15 INFO - 'talos_options': ['--e10s'], 10:42:15 INFO - 'tests': ['tp5o']}, 10:42:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:42:15 INFO - 'talos_options': ['--xperf_path', 10:42:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:42:15 INFO - 'tests': ['tp5n']}, 10:42:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:42:15 INFO - 'talos_options': ['--e10s', 10:42:15 INFO - '--xperf_path', 10:42:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:42:15 INFO - 'tests': ['tp5n']}}, 10:42:15 INFO - 'talos.zip': {'path': '', 10:42:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:42:15 INFO - Running post-action listener: _resource_record_post_action 10:42:15 INFO - ##### 10:42:15 INFO - ##### Running create-virtualenv step. 10:42:15 INFO - ##### 10:42:15 INFO - Running pre-action listener: _resource_record_pre_action 10:42:15 INFO - Running main action method: create_virtualenv 10:42:15 INFO - Creating virtualenv /builds/slave/test/build/venv 10:42:15 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 10:42:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:42:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:42:15 INFO - Using real prefix '/usr' 10:42:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:42:15 INFO - Installing distribute.............................................................................................................................................................................................done. 10:42:17 INFO - Installing pip.................done. 10:42:17 INFO - Return code: 0 10:42:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:42:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:42:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:42:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:42:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:42:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2cba71bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aec410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7b160>, '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 0x1b7c060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b7c4f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460655721.354275-1231228638', '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 10:42:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:42:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:42:17 INFO - Using env: {'DISPLAY': ':0', 10:42:17 INFO - 'HOME': '/home/cltbld', 10:42:17 INFO - 'LANG': 'en_US.UTF-8', 10:42:17 INFO - 'LANGUAGE': 'en_US:en', 10:42:17 INFO - 'LOGNAME': 'cltbld', 10:42:17 INFO - 'MAIL': '/var/mail/cltbld', 10:42:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:42:17 INFO - 'MOZ_NO_REMOTE': '1', 10:42:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:42:17 INFO - 'NO_EM_RESTART': '1', 10:42:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:42:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:42:17 INFO - 'PWD': '/builds/slave/test', 10:42:17 INFO - 'SHELL': '/bin/bash', 10:42:17 INFO - 'SHLVL': '1', 10:42:17 INFO - 'TERM': 'linux', 10:42:17 INFO - 'TMOUT': '86400', 10:42:17 INFO - 'USER': 'cltbld', 10:42:17 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460655721.354275-1231228638', 10:42:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:42:17 INFO - '_': '/tools/buildbot/bin/python'} 10:42:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:42:17 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 10:42:17 INFO - Cleaning up... 10:42:17 INFO - Return code: 0 10:42:17 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:42:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:42:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:42:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:42:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:42:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2cba71bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aec410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7b160>, '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 0x1b7c060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b7c4f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460655721.354275-1231228638', '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 10:42:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 10:42:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 10:42:17 INFO - Using env: {'DISPLAY': ':0', 10:42:17 INFO - 'HOME': '/home/cltbld', 10:42:17 INFO - 'LANG': 'en_US.UTF-8', 10:42:17 INFO - 'LANGUAGE': 'en_US:en', 10:42:17 INFO - 'LOGNAME': 'cltbld', 10:42:17 INFO - 'MAIL': '/var/mail/cltbld', 10:42:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:42:17 INFO - 'MOZ_NO_REMOTE': '1', 10:42:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:42:17 INFO - 'NO_EM_RESTART': '1', 10:42:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:42:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:42:17 INFO - 'PWD': '/builds/slave/test', 10:42:17 INFO - 'SHELL': '/bin/bash', 10:42:17 INFO - 'SHLVL': '1', 10:42:17 INFO - 'TERM': 'linux', 10:42:17 INFO - 'TMOUT': '86400', 10:42:17 INFO - 'USER': 'cltbld', 10:42:17 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460655721.354275-1231228638', 10:42:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:42:17 INFO - '_': '/tools/buildbot/bin/python'} 10:42:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:42:18 INFO - Downloading/unpacking psutil>=0.7.1 10:42:18 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 10:42:18 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 10:42:18 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 10:42:18 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 10:42:18 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 10:42:18 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 10:42:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:42:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:42:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:42:20 INFO - Installing collected packages: psutil 10:42:20 INFO - Running setup.py install for psutil 10:42:20 INFO - building 'psutil._psutil_linux' extension 10:42:20 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 10:42:20 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 10:42:20 INFO - building 'psutil._psutil_posix' extension 10:42:20 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 10:42:20 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 10:42:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:42:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:42:20 INFO - Successfully installed psutil 10:42:20 INFO - Cleaning up... 10:42:20 INFO - Return code: 0 10:42:20 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:42: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')]} 10:42:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:42:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42: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')]} 10:42:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:42:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:20 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 0x7f2cba71bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aec410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7b160>, '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 0x1b7c060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b7c4f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460655721.354275-1231228638', '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 10:42:20 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 10:42:20 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 10:42:20 INFO - Using env: {'DISPLAY': ':0', 10:42:20 INFO - 'HOME': '/home/cltbld', 10:42:20 INFO - 'LANG': 'en_US.UTF-8', 10:42:20 INFO - 'LANGUAGE': 'en_US:en', 10:42:20 INFO - 'LOGNAME': 'cltbld', 10:42:20 INFO - 'MAIL': '/var/mail/cltbld', 10:42:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:42:20 INFO - 'MOZ_NO_REMOTE': '1', 10:42:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:42:20 INFO - 'NO_EM_RESTART': '1', 10:42:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:42:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:42:20 INFO - 'PWD': '/builds/slave/test', 10:42:20 INFO - 'SHELL': '/bin/bash', 10:42:20 INFO - 'SHLVL': '1', 10:42:20 INFO - 'TERM': 'linux', 10:42:20 INFO - 'TMOUT': '86400', 10:42:20 INFO - 'USER': 'cltbld', 10:42:20 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460655721.354275-1231228638', 10:42:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:42:20 INFO - '_': '/tools/buildbot/bin/python'} 10:42:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:42:21 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:42:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:42:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:42:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:42:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:42:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:42:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:42:22 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:42:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:42:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:42:22 INFO - Installing collected packages: mozsystemmonitor 10:42:22 INFO - Running setup.py install for mozsystemmonitor 10:42:23 INFO - Successfully installed mozsystemmonitor 10:42:23 INFO - Cleaning up... 10:42:23 INFO - Return code: 0 10:42:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:42: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')]} 10:42:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:42:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42: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')]} 10:42:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:42:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:23 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 0x7f2cba71bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aec410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7b160>, '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 0x1b7c060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b7c4f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460655721.354275-1231228638', '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 10:42:23 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 10:42:23 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 10:42:23 INFO - Using env: {'DISPLAY': ':0', 10:42:23 INFO - 'HOME': '/home/cltbld', 10:42:23 INFO - 'LANG': 'en_US.UTF-8', 10:42:23 INFO - 'LANGUAGE': 'en_US:en', 10:42:23 INFO - 'LOGNAME': 'cltbld', 10:42:23 INFO - 'MAIL': '/var/mail/cltbld', 10:42:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:42:23 INFO - 'MOZ_NO_REMOTE': '1', 10:42:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:42:23 INFO - 'NO_EM_RESTART': '1', 10:42:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:42:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:42:23 INFO - 'PWD': '/builds/slave/test', 10:42:23 INFO - 'SHELL': '/bin/bash', 10:42:23 INFO - 'SHLVL': '1', 10:42:23 INFO - 'TERM': 'linux', 10:42:23 INFO - 'TMOUT': '86400', 10:42:23 INFO - 'USER': 'cltbld', 10:42:23 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460655721.354275-1231228638', 10:42:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:42:23 INFO - '_': '/tools/buildbot/bin/python'} 10:42:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:42:23 INFO - Downloading/unpacking blobuploader==1.2.4 10:42:23 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 10:42:23 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 10:42:23 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 10:42:23 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 10:42:23 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 10:42:23 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 10:42:25 INFO - Downloading blobuploader-1.2.4.tar.gz 10:42:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:42:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:42:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:42:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:42:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:42:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:42:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:42:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:42:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:42:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:42:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:42:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:42:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:42:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:42:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:42:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:42:25 INFO - Downloading docopt-0.6.1.tar.gz 10:42:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:42:25 INFO - Installing collected packages: blobuploader, requests, docopt 10:42:25 INFO - Running setup.py install for blobuploader 10:42:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:42:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:42:26 INFO - Running setup.py install for requests 10:42:26 INFO - Running setup.py install for docopt 10:42:26 INFO - Successfully installed blobuploader requests docopt 10:42:26 INFO - Cleaning up... 10:42:26 INFO - Return code: 0 10:42:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:42:26 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')]} 10:42:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:42:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:26 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')]} 10:42:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:42:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:26 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 0x7f2cba71bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aec410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7b160>, '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 0x1b7c060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b7c4f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460655721.354275-1231228638', '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 10:42:26 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 10:42:26 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 10:42:26 INFO - Using env: {'DISPLAY': ':0', 10:42:26 INFO - 'HOME': '/home/cltbld', 10:42:26 INFO - 'LANG': 'en_US.UTF-8', 10:42:26 INFO - 'LANGUAGE': 'en_US:en', 10:42:26 INFO - 'LOGNAME': 'cltbld', 10:42:26 INFO - 'MAIL': '/var/mail/cltbld', 10:42:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:42:26 INFO - 'MOZ_NO_REMOTE': '1', 10:42:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:42:26 INFO - 'NO_EM_RESTART': '1', 10:42:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:42:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:42:26 INFO - 'PWD': '/builds/slave/test', 10:42:26 INFO - 'SHELL': '/bin/bash', 10:42:26 INFO - 'SHLVL': '1', 10:42:26 INFO - 'TERM': 'linux', 10:42:26 INFO - 'TMOUT': '86400', 10:42:26 INFO - 'USER': 'cltbld', 10:42:26 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460655721.354275-1231228638', 10:42:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:42:26 INFO - '_': '/tools/buildbot/bin/python'} 10:42:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:42:26 INFO - Running setup.py (path:/tmp/pip-qykLXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:42:26 INFO - Running setup.py (path:/tmp/pip-VIAdk9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:42:26 INFO - Running setup.py (path:/tmp/pip-JJcpBj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:42:26 INFO - Running setup.py (path:/tmp/pip-27PeDs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:42:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:42:27 INFO - Running setup.py (path:/tmp/pip-RvEhw4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:42:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:42:27 INFO - Running setup.py (path:/tmp/pip-b3VMdv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:42:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:42:27 INFO - Running setup.py (path:/tmp/pip-tZqCOi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:42:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:42:27 INFO - Running setup.py (path:/tmp/pip-DEYwNg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:42:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:42:27 INFO - Running setup.py (path:/tmp/pip-0Klf7M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:42:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:42:27 INFO - Running setup.py (path:/tmp/pip-l5GcQE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:42:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:42:27 INFO - Running setup.py (path:/tmp/pip-z0u6VC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:42:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:42:27 INFO - Running setup.py (path:/tmp/pip-svgrjh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:42:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:42:27 INFO - Running setup.py (path:/tmp/pip-7qG0Ec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:42:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:42:27 INFO - Running setup.py (path:/tmp/pip-Cs4mWe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:42:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:42:27 INFO - Running setup.py (path:/tmp/pip-IUv10I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:42:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:42:27 INFO - Running setup.py (path:/tmp/pip-g_9KUV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:42:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:42:27 INFO - Running setup.py (path:/tmp/pip-JND5Iq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:42:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:42:27 INFO - Running setup.py install for manifestparser 10:42:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:42:28 INFO - Running setup.py install for mozcrash 10:42:28 INFO - Running setup.py install for mozdebug 10:42:28 INFO - Running setup.py install for mozdevice 10:42:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:42:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:42:28 INFO - Running setup.py install for mozfile 10:42:28 INFO - Running setup.py install for mozhttpd 10:42:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:42:28 INFO - Running setup.py install for mozinfo 10:42:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:42:28 INFO - Running setup.py install for mozInstall 10:42:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:42:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:42:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:42:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:42:28 INFO - Running setup.py install for mozleak 10:42:28 INFO - Running setup.py install for mozlog 10:42:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:42:29 INFO - Running setup.py install for moznetwork 10:42:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:42:29 INFO - Running setup.py install for mozprocess 10:42:29 INFO - Running setup.py install for mozprofile 10:42:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:42:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:42:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:42:29 INFO - Running setup.py install for mozrunner 10:42:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:42:29 INFO - Running setup.py install for mozscreenshot 10:42:29 INFO - Running setup.py install for moztest 10:42:29 INFO - Running setup.py install for mozversion 10:42:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:42:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:42:29 INFO - Cleaning up... 10:42:29 INFO - Return code: 0 10:42:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:42:29 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')]} 10:42:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:42:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:29 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')]} 10:42:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:42:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:29 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 0x7f2cba71bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aec410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7b160>, '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 0x1b7c060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b7c4f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460655721.354275-1231228638', '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 10:42:29 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 10:42:29 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 10:42:29 INFO - Using env: {'DISPLAY': ':0', 10:42:29 INFO - 'HOME': '/home/cltbld', 10:42:29 INFO - 'LANG': 'en_US.UTF-8', 10:42:29 INFO - 'LANGUAGE': 'en_US:en', 10:42:29 INFO - 'LOGNAME': 'cltbld', 10:42:29 INFO - 'MAIL': '/var/mail/cltbld', 10:42:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:42:29 INFO - 'MOZ_NO_REMOTE': '1', 10:42:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:42:29 INFO - 'NO_EM_RESTART': '1', 10:42:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:42:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:42:29 INFO - 'PWD': '/builds/slave/test', 10:42:29 INFO - 'SHELL': '/bin/bash', 10:42:29 INFO - 'SHLVL': '1', 10:42:29 INFO - 'TERM': 'linux', 10:42:29 INFO - 'TMOUT': '86400', 10:42:29 INFO - 'USER': 'cltbld', 10:42:29 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460655721.354275-1231228638', 10:42:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:42:29 INFO - '_': '/tools/buildbot/bin/python'} 10:42:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:42:30 INFO - Running setup.py (path:/tmp/pip-rMUrds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:42:30 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)) 10:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:42:30 INFO - Running setup.py (path:/tmp/pip-FQcsDB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:42:30 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)) 10:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:42:30 INFO - Running setup.py (path:/tmp/pip-qFYU_n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:42:30 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)) 10:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:42:30 INFO - Running setup.py (path:/tmp/pip-LA0z6a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:42:30 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)) 10:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:42:30 INFO - Running setup.py (path:/tmp/pip-5sMc4r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:42:30 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)) 10:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:42:30 INFO - Running setup.py (path:/tmp/pip-st6yT_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:42:30 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)) 10:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:42:30 INFO - Running setup.py (path:/tmp/pip-HRrq8w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:42:30 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)) 10:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:42:30 INFO - Running setup.py (path:/tmp/pip-ioUShT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:42:30 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)) 10:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:42:30 INFO - Running setup.py (path:/tmp/pip-BKPjDf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:42:30 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)) 10:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:42:30 INFO - Running setup.py (path:/tmp/pip-Wao5fu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:42:30 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)) 10:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:42:30 INFO - Running setup.py (path:/tmp/pip-XkScvv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:42:30 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)) 10:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:42:30 INFO - Running setup.py (path:/tmp/pip-1G9Y6o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:42:30 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)) 10:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:42:30 INFO - Running setup.py (path:/tmp/pip-RG9nbi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:42:30 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)) 10:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:42:30 INFO - Running setup.py (path:/tmp/pip-uJ5tCC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:42:31 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)) 10:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:42:31 INFO - Running setup.py (path:/tmp/pip-0I2xm2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:42:31 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)) 10:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:42:31 INFO - Running setup.py (path:/tmp/pip-nqUXMt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:42:31 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)) 10:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:42:31 INFO - Running setup.py (path:/tmp/pip-KiKSZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:42:31 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)) 10:42:31 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)) 10:42:31 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)) 10:42:31 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)) 10:42:31 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)) 10:42:31 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)) 10:42:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:42:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:42:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:42:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:42:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:42:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:42:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:42:33 INFO - Downloading blessings-1.6.tar.gz 10:42:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:42:33 INFO - Installing collected packages: blessings 10:42:33 INFO - Running setup.py install for blessings 10:42:33 INFO - Successfully installed blessings 10:42:33 INFO - Cleaning up... 10:42:33 INFO - Return code: 0 10:42:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:42:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:42:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:42:33 INFO - Reading from file tmpfile_stdout 10:42:33 INFO - Current package versions: 10:42:33 INFO - argparse == 1.2.1 10:42:33 INFO - blessings == 1.6 10:42:33 INFO - blobuploader == 1.2.4 10:42:33 INFO - docopt == 0.6.1 10:42:33 INFO - manifestparser == 1.1 10:42:33 INFO - mozInstall == 1.12 10:42:33 INFO - mozcrash == 0.17 10:42:33 INFO - mozdebug == 0.1 10:42:33 INFO - mozdevice == 0.48 10:42:33 INFO - mozfile == 1.2 10:42:33 INFO - mozhttpd == 0.7 10:42:33 INFO - mozinfo == 0.9 10:42:33 INFO - mozleak == 0.1 10:42:33 INFO - mozlog == 3.1 10:42:33 INFO - moznetwork == 0.27 10:42:33 INFO - mozprocess == 0.22 10:42:33 INFO - mozprofile == 0.28 10:42:33 INFO - mozrunner == 6.11 10:42:33 INFO - mozscreenshot == 0.1 10:42:33 INFO - mozsystemmonitor == 0.0 10:42:33 INFO - moztest == 0.7 10:42:33 INFO - mozversion == 1.4 10:42:33 INFO - psutil == 3.1.1 10:42:33 INFO - requests == 1.2.3 10:42:33 INFO - wsgiref == 0.1.2 10:42:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:42:33 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')]} 10:42:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:42:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:33 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')]} 10:42:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:42:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:33 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 0x7f2cba71bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aec410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7b160>, '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 0x1b7c060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b7c4f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460655721.354275-1231228638', '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 10:42:33 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 10:42:33 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 10:42:33 INFO - Using env: {'DISPLAY': ':0', 10:42:33 INFO - 'HOME': '/home/cltbld', 10:42:33 INFO - 'LANG': 'en_US.UTF-8', 10:42:33 INFO - 'LANGUAGE': 'en_US:en', 10:42:33 INFO - 'LOGNAME': 'cltbld', 10:42:33 INFO - 'MAIL': '/var/mail/cltbld', 10:42:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:42:33 INFO - 'MOZ_NO_REMOTE': '1', 10:42:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:42:33 INFO - 'NO_EM_RESTART': '1', 10:42:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:42:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:42:33 INFO - 'PWD': '/builds/slave/test', 10:42:33 INFO - 'SHELL': '/bin/bash', 10:42:33 INFO - 'SHLVL': '1', 10:42:33 INFO - 'TERM': 'linux', 10:42:33 INFO - 'TMOUT': '86400', 10:42:33 INFO - 'USER': 'cltbld', 10:42:33 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460655721.354275-1231228638', 10:42:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:42:33 INFO - '_': '/tools/buildbot/bin/python'} 10:42:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:42:33 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)) 10:42:33 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)) 10:42:33 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)) 10:42:33 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)) 10:42:33 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)) 10:42:33 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)) 10:42:33 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)) 10:42:33 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)) 10:42:33 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)) 10:42:33 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)) 10:42:33 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)) 10:42:33 INFO - Cleaning up... 10:42:33 INFO - Return code: 0 10:42:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:42:33 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')]} 10:42:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:42:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:33 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')]} 10:42:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:42:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:33 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 0x7f2cba71bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aec410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7b160>, '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 0x1b7c060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b7c4f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460655721.354275-1231228638', '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 10:42:33 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 10:42:33 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 10:42:33 INFO - Using env: {'DISPLAY': ':0', 10:42:33 INFO - 'HOME': '/home/cltbld', 10:42:33 INFO - 'LANG': 'en_US.UTF-8', 10:42:33 INFO - 'LANGUAGE': 'en_US:en', 10:42:33 INFO - 'LOGNAME': 'cltbld', 10:42:33 INFO - 'MAIL': '/var/mail/cltbld', 10:42:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:42:33 INFO - 'MOZ_NO_REMOTE': '1', 10:42:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:42:33 INFO - 'NO_EM_RESTART': '1', 10:42:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:42:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:42:33 INFO - 'PWD': '/builds/slave/test', 10:42:33 INFO - 'SHELL': '/bin/bash', 10:42:33 INFO - 'SHLVL': '1', 10:42:33 INFO - 'TERM': 'linux', 10:42:33 INFO - 'TMOUT': '86400', 10:42:33 INFO - 'USER': 'cltbld', 10:42:33 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460655721.354275-1231228638', 10:42:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:42:33 INFO - '_': '/tools/buildbot/bin/python'} 10:42:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:42:33 INFO - Downloading/unpacking jsonschema 10:42:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:42:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:42:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:42:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:42:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:42:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:42:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:42:35 INFO - Downloading/unpacking functools32 (from jsonschema) 10:42:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:42:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:42:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:42:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:42:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:42:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:42:36 INFO - Downloading functools32-3.2.3-2.tar.gz 10:42:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:42:36 INFO - warning: no files found matching '*.txt' 10:42:36 INFO - no previously-included directories found matching 'build' 10:42:36 INFO - no previously-included directories found matching 'dist' 10:42:36 INFO - no previously-included directories found matching '.git*' 10:42:36 INFO - Installing collected packages: jsonschema, functools32 10:42:36 INFO - Running setup.py install for functools32 10:42:36 INFO - warning: no files found matching '*.txt' 10:42:36 INFO - no previously-included directories found matching 'build' 10:42:36 INFO - no previously-included directories found matching 'dist' 10:42:36 INFO - no previously-included directories found matching '.git*' 10:42:36 INFO - Successfully installed jsonschema functools32 10:42:36 INFO - Cleaning up... 10:42:36 INFO - Return code: 0 10:42:36 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:42:36 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')]} 10:42:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:42:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:36 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')]} 10:42:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:42:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:36 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 0x7f2cba71bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aec410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7b160>, '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 0x1b7c060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b7c4f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460655721.354275-1231228638', '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 10:42:36 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 10:42:36 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 10:42:36 INFO - Using env: {'DISPLAY': ':0', 10:42:36 INFO - 'HOME': '/home/cltbld', 10:42:36 INFO - 'LANG': 'en_US.UTF-8', 10:42:36 INFO - 'LANGUAGE': 'en_US:en', 10:42:36 INFO - 'LOGNAME': 'cltbld', 10:42:36 INFO - 'MAIL': '/var/mail/cltbld', 10:42:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:42:36 INFO - 'MOZ_NO_REMOTE': '1', 10:42:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:42:36 INFO - 'NO_EM_RESTART': '1', 10:42:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:42:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:42:36 INFO - 'PWD': '/builds/slave/test', 10:42:36 INFO - 'SHELL': '/bin/bash', 10:42:36 INFO - 'SHLVL': '1', 10:42:36 INFO - 'TERM': 'linux', 10:42:36 INFO - 'TMOUT': '86400', 10:42:36 INFO - 'USER': 'cltbld', 10:42:36 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460655721.354275-1231228638', 10:42:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:42:36 INFO - '_': '/tools/buildbot/bin/python'} 10:42:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:42:36 INFO - Downloading/unpacking flake8 10:42:36 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 10:42:36 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 10:42:36 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 10:42:36 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 10:42:36 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 10:42:36 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 10:42:38 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:42:38 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:42:38 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 10:42:38 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 10:42:38 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 10:42:38 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 10:42:38 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 10:42:38 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 10:42:38 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:42:38 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:42:38 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 10:42:38 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 10:42:38 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 10:42:38 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 10:42:38 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 10:42:38 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 10:42:38 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:42:38 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 10:42:38 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 10:42:38 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 10:42:38 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 10:42:38 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 10:42:38 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 10:42:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:42:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:42:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:42:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:42:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:42:39 INFO - no previously-included directories found matching 'docs/_build' 10:42:39 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:42:39 INFO - Running setup.py install for pep8 10:42:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:42:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:42:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:42:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:42:39 INFO - no previously-included directories found matching 'docs/_build' 10:42:39 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:42:39 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:42:39 INFO - Cleaning up... 10:42:39 INFO - Return code: 0 10:42:39 INFO - Running post-action listener: _resource_record_post_action 10:42:39 INFO - Running post-action listener: _start_resource_monitoring 10:42:39 INFO - Starting resource monitoring. 10:42:39 INFO - ##### 10:42:39 INFO - ##### Running install step. 10:42:39 INFO - ##### 10:42:39 INFO - Running pre-action listener: _resource_record_pre_action 10:42:39 INFO - Running main action method: install 10:42:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:42:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:42:39 INFO - Reading from file tmpfile_stdout 10:42:39 INFO - Detecting whether we're running mozinstall >=1.0... 10:42:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:42:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:42:39 INFO - Reading from file tmpfile_stdout 10:42:39 INFO - Output received: 10:42:39 INFO - Usage: mozinstall [options] installer 10:42:39 INFO - Options: 10:42:39 INFO - -h, --help show this help message and exit 10:42:39 INFO - -d DEST, --destination=DEST 10:42:39 INFO - Directory to install application into. [default: 10:42:39 INFO - "/builds/slave/test"] 10:42:39 INFO - --app=APP Application being installed. [default: firefox] 10:42:39 INFO - mkdir: /builds/slave/test/build/application 10:42:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:42:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:42:54 INFO - Reading from file tmpfile_stdout 10:42:54 INFO - Output received: 10:42:54 INFO - /builds/slave/test/build/application/firefox/firefox 10:42:54 INFO - Running post-action listener: _resource_record_post_action 10:42:54 INFO - ##### 10:42:54 INFO - ##### Running run-tests step. 10:42:54 INFO - ##### 10:42:54 INFO - Running pre-action listener: _resource_record_pre_action 10:42:54 INFO - Running main action method: run_tests 10:42:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:42:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:42:54 INFO - Python 2.7.3 10:42:54 INFO - Return code: 0 10:42:54 INFO - grabbing minidump binary from tooltool 10:42:54 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')]} 10:42:54 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 0x1b7b160>, '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 0x1b7c060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b7c4f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:42:54 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 10:42:54 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 10:42:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:42:54 INFO - Return code: 0 10:42:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:42:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:42:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:42:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:42:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:42:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:42:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:42:55 INFO - Return code: 0 10:42:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RwmgRKunR7qEQJ-LSeMHLg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:42:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RwmgRKunR7qEQJ-LSeMHLg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:42:55 INFO - Using env: {'DISPLAY': ':0', 10:42:55 INFO - 'HOME': '/home/cltbld', 10:42:55 INFO - 'LANG': 'en_US.UTF-8', 10:42:55 INFO - 'LANGUAGE': 'en_US:en', 10:42:55 INFO - 'LOGNAME': 'cltbld', 10:42:55 INFO - 'MAIL': '/var/mail/cltbld', 10:42:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:42:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:42:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:42:55 INFO - 'MOZ_NO_REMOTE': '1', 10:42:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:42:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:42:55 INFO - 'NO_EM_RESTART': '1', 10:42:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:42:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:42:55 INFO - 'PWD': '/builds/slave/test', 10:42:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:42:55 INFO - 'SHELL': '/bin/bash', 10:42:55 INFO - 'SHLVL': '1', 10:42:55 INFO - 'TERM': 'linux', 10:42:55 INFO - 'TMOUT': '86400', 10:42:55 INFO - 'USER': 'cltbld', 10:42:55 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460655721.354275-1231228638', 10:42:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:42:55 INFO - '_': '/tools/buildbot/bin/python'} 10:42:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RwmgRKunR7qEQJ-LSeMHLg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:42:56 INFO - mozversion application_buildid: 20160414075542 10:42:56 INFO - mozversion application_changeset: 949d0760be73d73ee1fa7dab0b5a7102f169ece3 10:42:56 INFO - mozversion application_display_name: FirefoxDeveloperEdition 10:42:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:42:56 INFO - mozversion application_name: Firefox 10:42:56 INFO - mozversion application_remotingname: firefox-dev 10:42:56 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:42:56 INFO - mozversion application_vendor: Mozilla 10:42:56 INFO - mozversion application_version: 47.0a2 10:42:56 INFO - mozversion platform_buildid: 20160414075542 10:42:56 INFO - mozversion platform_changeset: 949d0760be73d73ee1fa7dab0b5a7102f169ece3 10:42:56 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:42:56 INFO - mozversion platform_version: 47.0a2 10:42:56 INFO - using testdate: 1460655776 10:42:56 INFO - actual date: 1460655776 10:42:56 INFO - starting webserver on 'localhost:48016' 10:42:56 INFO - SUITE-START | Running 2 tests 10:42:56 INFO - TEST-START | dromaeo_css 10:42:56 INFO - operating with platform_type : linux_ 10:42:56 INFO - Initialising browser for dromaeo_css test... 10:42:56 INFO - TEST-INFO | started process 4413 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmph62g2h/profile http://localhost:48016/getInfo.html) 10:43:00 INFO - PROCESS | 4413 | __metrics Screen width/height:1600/1200 10:43:00 INFO - PROCESS | 4413 | colorDepth:24 10:43:00 INFO - PROCESS | 4413 | Browser inner width/height: 1024/697 10:43:00 INFO - PROCESS | 4413 | __metrics 10:43:02 INFO - PROCESS | 4413 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:43:03 INFO - TEST-INFO | 4413: exit 0 10:43:03 INFO - Browser initialized. 10:43:03 INFO - Running cycle 1/1 for dromaeo_css test... 10:43:03 INFO - TEST-INFO | started process 4504 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmph62g2h/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:43:14 INFO - PROCESS | 4504 | RSS: Main: 142131200 10:43:14 INFO - PROCESS | 4504 | 10:44:06 INFO - PROCESS | 4504 | 1460655846061 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] 10:46:13 INFO - PROCESS | 4504 | Cycle 1(1): loaded http://localhost:48016/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48016/tests/dromaeo/cssquery-ext.html) 10:46:14 INFO - PROCESS | 4504 | RSS: Main: 259194880 10:46:14 INFO - PROCESS | 4504 | 10:49:16 INFO - PROCESS | 4504 | Cycle 1(1): loaded http://localhost:48016/tests/dromaeo/cssquery-ext.html (next: http://localhost:48016/tests/dromaeo/cssquery-jquery.html) 10:49:17 INFO - PROCESS | 4504 | RSS: Main: 220938240 10:49:17 INFO - PROCESS | 4504 | 10:52:18 INFO - PROCESS | 4504 | Cycle 1(1): loaded http://localhost:48016/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48016/tests/dromaeo/cssquery-mootools.html) 10:52:19 INFO - PROCESS | 4504 | RSS: Main: 222154752 10:52:19 INFO - PROCESS | 4504 | 10:55:21 INFO - PROCESS | 4504 | Cycle 1(1): loaded http://localhost:48016/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48016/tests/dromaeo/cssquery-prototype.html) 10:55:21 INFO - PROCESS | 4504 | RSS: Main: 192012288 10:55:21 INFO - PROCESS | 4504 | 10:58:24 INFO - PROCESS | 4504 | Cycle 1(1): loaded http://localhost:48016/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48016/tests/dromaeo/cssquery-yui.html) 10:58:25 INFO - PROCESS | 4504 | RSS: Main: 205819904 10:58:25 INFO - PROCESS | 4504 | 11:01:27 INFO - PROCESS | 4504 | Cycle 1(1): loaded http://localhost:48016/tests/dromaeo/cssquery-yui.html (next: http://localhost:48016/tests/dromaeo/cssquery-dojo.html) 11:01:27 INFO - PROCESS | 4504 | RSS: Main: 254283776 11:01:27 INFO - PROCESS | 4504 | 11:01:27 INFO - PROCESS | 4504 | __start_tp_report 11:01:27 INFO - PROCESS | 4504 | _x_x_mozilla_page_load 11:01:27 INFO - PROCESS | 4504 | _x_x_mozilla_page_load_details 11:01:27 INFO - PROCESS | 4504 | |i|pagename|runs| 11:01:27 INFO - PROCESS | 4504 | |0;dojo.html;3211.7270032047277;3276.459384201607;3287.9178020549484;3297.0603378037263;3333.200031992321;5227;5247.947520524794;5253.185756207789;5263.947360526398;5284.048871203182;5271.051210782058;5275.261463395118;5288.576913846892;5302.602304827144;5330.040592693314;4753.786079626425;4828.879278018051;4845.466998630165;4881.267809828519;4917.385326834145;4865.635077369211;4932.062908047459;4946.332245146913;4956.7025978441225;4957.5786058185095;4827.372441582607;4882.829100981467;4883;4895.902081958358;4930.285108659242;4885.5358740919555;4909.361782968227;4914.238293064581;4915.754212289371;4927.260910863363;4759.333693282943;4790.94599188178;4871.244957031666;4877.926831097537;4898.020395920795;5067.847964561069;5078.263651770472;5081.161608334621;5099.566536844335;5155.9484405155845;5554.888902221974;5585.664860108406;5609.9902017636805;5650.378458369576;5655.802046928379;5714.685692286923;5734.082546792535;5739.426057394269;5755.971220143914;5762.366139724627;5370.462953704638;5386.649867758622;5389.946100539023;5390.353157621072;5393.7572809223675;5684.744186511617;5785.479306862402;5869.383714709979;5882.117682347596;5892.027815410495;5593.412691667398;5649.774009039593;5651.124075768263;5652.576056795757;5656.773729050874;5722.7424765885635;5737.827865164052;5737.8565535861935;5743.10981797822;5745.569082318842;5453.672779633234;5593.664380137205;5728.169415434739;5745.1669507921115;5768.105943578752;5652.773889044474;5663.150527420919;5664.971675141598;5669.688167150846;5671.092625179951;4264.360345948071;4361.542038085955;4364.454443194601;4368.672349573794;4386.298192289219;3898.0254936265933;3961.1087505311652;3976.0258736609717;3980.44273801668;4001.9399709004388;5374.274472946102;5375.973120134374;5381.0583147948955;5382.67703937765;5409.891802163935;5602.887942241214;5663.235463212496;5667.716614169275;5670.177824215466;5761.827145185651;5370.4629537045985;5394.352677678625;5395.05586522357;5397.487238712316;5400.864978375572;4795.640326975491;4798.832040878552;4802.495737947535;4806.182948898696;4833.709977401367;5649.237352957381;5800.100984347433;5909;5998.610090344114;6011.549133814981;5687.03320435527;5695.515881149983;5703.828885133453;5706.457886500776;5712.6286791358425;5845.649261044181;5858.5898987070495;5861.1794348792055;5864.794732184524;5894.440028197314;5451.727413629382;5560.277163968658;5610.6072574921;5621.578381621476;5625.071863142535;5679.37526872052;5690.829275121753;5701.458361455655;5704.80033198836;5711.942880571141;5386.245925570502;5559.861003474945;5563.221149039056;5563.610547261653;5566.526845218202;5503.614746967673;5563.082091454865;5563.7496312666835;5581.9162712560155;5602.887942241051;5383.084875571084;5385.3268341457315;5390.272313237662;5392.325959255093;5393.379761327341;5437.972810135924;5477.452254774491;5497.257870187634;5532.668039917457;5575.749091290821;5331.360236771612;5455.590830687794;5534.972325138348;5535.667859928417;5608.214849921096 11:01:27 INFO - PROCESS | 4504 | |1;ext.html;547.2256756689285;562.9465200805922;574.3768011707298;595.3599880128861;641.304184959319;37537.81231093844;39869;39938.201235975335;39947.60052399475;40002.59997400025;43560;43925.341119883225;43943.340849887194;44082.55917440825;44341;8882.37823352364;9040.141186587263;9106.817863642724;9108.499032553207;9117.088291170863;8728.694495692653;8842.248408885253;8857.379983401164;8866.86699699505;8870.112988701143;9136.725898223063;9192.494412807293;9200.401973871676;9201.125893040151;9203.125703058198;8995.235404990552;9002.909970900273;9057.411268267542;9058.954705226432;9059.50172740499;9169.266458683289;9306.767330816716;9317.627294908263;9320.8601870972;9321.021292764297;43144.78427607873;43602;43604.781976089915;43610.781946090385;43627.34558981618;3585.928281434383;3786.583475817658;3800.1449673823445;3878.495795546561;4459.175052615276;32530.83734581312;32965.50551741726;33007.6699233007;33069.18911892492;34459.827700861584;4369.694121411502;4371.737695738266;4412.845550405753;4422.402975598286;4443.622292105175;292208;292713;293528;293534.99999999785;294120;46028;66900;67166.66416667885;67226.66386668134;67328.66335668389;44822.77588612036;44932.3260151098;44938.55061449409;44987;45087;16712.665746684997;16950;17008.48974530766;17009.404670836462;17022.148892555324;14196.148231106166;14205.715885682228;14213.857861421253;14285.9999800013;14423.42306307757;15965.281562329723;15991.760123598155;15992.680146397008;15994.520164395086;16029.839701602834;5819.301683797887;5892.351841297454;6024.8795024100145;6076.605020673642;6081.695915204222;1010.8433192855119;1060.9151267898549;1194.325206258461;1204.6093730555867;1255.6609715376796;30594.69405305963;30643.233919151753;30879.69120308768;31035.84482077575;31185.22036949049;1129.48043899807;1142.5943789954447;1238.3189245914712;1258.4651523102646;1281.5450515067203;16141.757873631905;16175.272112754954;16328;16424.09667468277;16596.419125330554;310857;315944;316933;318130;318493;58888.41111588915;59241.111383329284;59288.70355648194;59298;59354;1269.2321145706899;1492.6193820575684;1514.0612820051638;1557.0424189123607;1620.586750378646;29712.40575188441;30458.390832183675;30801;33031;33074.33851323008;56446.717766410904;57158;57364.71317643385;57378.13932791095;57469;293884;296640;296721;296903;297170;34947;46060.53939460697;48389.758051209516;48890;49124.75437622789;44247.336289955034;44495.332570010825;44574.3313850299;45703.31445028261;49285.260721088496;40127.79936100301;40710.982225444604;40954.385684215355;41093.1781364377;41550.58449415588;39167;40048.79975600103;40201.1959760809;40858;41217.58782412257;39588.60411395849;39851.80074099611;40071.799641001606;40589.1882162361;40867.182656346115;35204.887706737674;36854.44718329281;37122;37155.814220928725;37499.25001500009;27910.72089279081;27997.720022800328;28128.156155315373;28165.15504534867;28388.43223135567 11:01:27 INFO - PROCESS | 4504 | |2;jquery.html;386.92068126034155;389.8674450686768;395.7922090902278;400.6534347789162;402.54713447371705;17166.39917602884;19241.23035078597;19424.805751942476;19622;19712.507187320305;17525.561860953483;17559.29762809486;18112.72830907534;18221.7266740999;18241;5646.661200327983;5796.362400135981;5801.9129713054335;5839.678817665027;5840.853978650525;4199;6048.576599638027;6288.465480434169;6311.810645680637;6315.336889626569;6145.754169833223;6258.593191442542;6259.155014073087;6290.905636415458;6299.716512756937;6411.166548348685;6419.8395040123905;6436.259830119549;6441.6779161041995;6442.549021568492;3853.113783829735;5376.193570964348;5574;5575.414581468968;5590.496855283044;20130.295439659687;20247.190112395485;20843.89578052115;22051.889740551356;22108.778912210993;2237.5524895021063;2374.3351861478814;2514.0697941761664;2598.610208468726;3120.0951724000015;13219.86780132196;13768.24274664893;13815.171089734547;14062.578122656336;14228.786568201485;1968.5472341361424;2004.488855341893;2020.444377796103;2024.3016159424974;2045.1001559313854;64933.67533162351;64995;65012.3498765011;66049;66849;9766.121049105615;9860.112589866947;9877.506124693737;10215;10327.225458090674;12946.482140714266;12967.351632418342;13042;13101.737965240642;13114.01644876619;8003.9599802001785;8063.475874068166;8126.228008339198;8127.878081828777;8144.75565733029;8149.51102933814;8161.387895907831;8196.631151598192;8317.8336433271;8329.08380078191;6032.758689652364;6172.598781079216;6193.4425901669065;6217.751289948442;6272.655003974825;1671.4317132174876;1834.067657381829;1892.2903911033363;1909.1313452379134;1919.5009297582728;940.9905900941039;1054;1069.3316677076828;1085.8914108589079;1149.7183190118474;17462.738058929128;17625.294988200327;17756.289748410178;17956.640867182585;18267.086645667663;974.6247694637474;987.6493844685033;1025.5846382215216;1057.2968975631272;1063.4363787192801;10265.948670256601;10300.124489418484;10513.737156571147;10545.367277963347;10783.083437907866;433572;437801;451849;454835;464484;66810;67213.66393168003;67994.66002670054;68824.31175688279;69422.30577694159;1071.7320669832543;1085.9728506787394;1091.0998426298336;1093.1528065748948;1103.420704130338;15739.606509836887;15958;16034.358625654842;16057.19714014318;16141.435049773201;32155.196120097185;32211.838940806083;32479.18802029968;33035.339293214485;33896.830515847265;45321.54678453305;45916.311255331864;45963;46142.30786538272;46368.53631463777;8365;8461.534615596202;8586.828263434822;8632.525211113449;8808.11918808114;12999.1550549214;13127.081104322606;13173.473061077833;13222.404991775586;13275.402606882906;10736.838947415952;10987.175961803057;11098.833517497082;11734.295942243492;11852;11375.829362559403;11463.942680286546;11488.48301826403;11737.823932640846;11959.940200298943;11331.093512519143;11424.82862757076;11445.599404020819;11624.709382265512;11666.88333116658;8151.5109093454585;8228.670853166046;8297.792555186168;8309.709160179365;8412.62143203545;11355.602553910574;11520.539178433104;11582.189246752983;11597.18819682614;11604.88395116038 11:01:27 INFO - PROCESS | 4504 | |3;mootools.html;1281.8974482041438;1599.8880078394513;1601.4555051282562;1863.9068046597674;1953.9316123935664;8140.592970351481;8321.708740194095;8326.084130745621;8334.624941877615;8341.91658083419;8396.160383961616;8534.57327133644;8589.398742088057;8589.742307730763;8598.91401085989;2111.978880211201;2388.988055059727;2413.3242692046256;2424.7696468835434;2486.589712697412;2455.7175924768703;2482.9751702482927;2489.3403248139257;2489.4149874779414;2492.6011838105906;2438.902443902242;2458.8278820482574;2470.3083136721657;2470.4441500662388;2471.962920556184;2372.240882917467;2381.5475059738683;2396.2691379129446;2399.8440101393353;2400.2079313826393;2383.3088404362716;2383.9391470795504;2393.3366310414267;2443.389152711822;2444.4377793107683;8635.39552231344;8662.826743465159;8692.391532592721;8699.043105258417;8716.694915677921;5146.536811686966;5256.92114618281;5261.657992230493;5302.973485132588;5305.522502974751;3274.3778682050333;3291.983540082308;3358.4794356874722;3363.226457914669;3367.983160084184;1070.68414817629;1080.2924084724518;1087.255230167338;1090.841827934945;1119.5074167366333;12039.93980030103;12088.576899808464;12088.879111208864;12090.697732556668;12095.758084838342;4652.092841895797;4704.1062198182235;4773.474917759044;4790.760461976957;4806.759662016885;10201.693949181536;10210.081092701692;10210.540525676362;10210.693679189637;10219.029192226726;4576.290674945389;5374.6506477078865;5376.381716102698;5378.435264297271;5381.48875856793;4761.381020467386;4797.832075877328;4862.027594481118;4873.049755297754;4873.634477414208;3873.070463088895;3973.0663294125857;3980.681545476355;3994.261061703536;4026.7382620129597;1302.6482849630547;1318.7626227279181;1323.1928523600595;1330.374723879775;1333.6532501549666;1434.6628542292553;1447.4499690117689;1449.54339383094;1460.8173978252719;1482.1255459279078;7972.840543189103;8014.959925200454;8034.196580341919;8073.273405393543;8088.272055514914;543.2855794630049;545.6507834985613;551.1677367175594;553.3608681972329;553.8366181976327;6029.487493563009;6052.303985041688;6054.39456054391;6117.265928088569;6134.601250918676;10376.221783366278;10571.94714026425;10590.311629744043;10715.732106697238;10745;9814.754631134136;10327;10469.633562825264;10513.369197848153;10553.84169237462;7961.761147165595;8057.959710201529;8081.555514446644;8107.473014254055;8169;7801.063872335356;7808.88286675689;7886.05367355898;7909.24862138096;7957.244061814118;9188.448693078437;9217.170454659114;9260.212881905114;9312.161905428544;9440;9577.521123943914;9652.372595781251;9669.371490853073;9743.512824358611;9976.950115249378;6692.263850976486;7605.619719013916;7724.1117271514495;7802.804929876798;8038.517688938682;8093.919060809552;8185.0996390398195;8190.631421585924;8204.958975205085;8222;7294.854102918018;7452.664630091767;7459.067616547932;7611.581363025087;7617.961910190414;7342.9632851835395;7391.6304184791625;7410.333070023724;7500.474966752275;7512.774616761506;7722.459427839997;7723.420743444377;7739.883901741366;7789.532628042336;7792.532448053135;6969.965150174216;7080.221175670569;7100.254473280231;7101.4673899458785;7140.9285907140265;7166.713331466683;7295.124585049828;7333.083364579427;7361.5583065014125;7365.705371785069 11:01:27 INFO - PROCESS | 4504 | |4;prototype.html;366.10852573982356;368.4767629965449;372.36511747470564;374.1338800676435;374.7657713928793;5888;5920.792772252972;5925.348211696715;5934.436228558291;5996.550258730591;5902.881942361161;5920.141579470974;5921.85195370116;5925.437083477073;5936.4953978911735;4457.687961842672;4544.5682660147395;4666.066786642668;4670.065986802636;4708.058388322332;4663.2305669564485;4665.206914824488;4684.063187362524;4684.718916864982;4688.695234809727;4644.790984405709;4658.883527911812;4661.067786442708;4662.673612847102;4664.883377915546;4391.692581519279;4482.484514280851;4596.724196548218;4627.884302892455;4643.303504474322;4125.834966601333;4129.421880936671;4129.566395528456;4131.648809851166;4139.606737359946;5643.125315576092;5650.208970744099;5656.377798442168;5659.688717120557;5666.716664166775;5388.865278368033;5402.108652072403;5407.188921661743;5413.593980451482;5413.945860541384;6251;6268.968655156695;6269.216347956505;6269.686515674243;6276.87446251077;4352.129574085196;4473.619742321874;4508.053308805155;4516.954830451719;4568.291914753186;6519.804405867784;6544.672766361663;6636.13730215069;6645.800625981228;6653.93346066538;4581.358609794632;4585;4586.334981427741;4586.6789324747615;4588.9541104588525;4650.209464391061;4654.650901182425;4656.906861862743;4657.208274593328;4659.44086709597;5324.334458192726;5330.733463326818;5331.173668081454;5333.813316533902;5338.065838478251;6155.384461553809;6193.1329613854095;6285.59143655661;6288.119663247149;6341.175647165931;1609.203444295058;1609.2195285286627;1613.8708903287709;1623.3993422433775;1630.877684173668;1028.6708253358854;1078.660222030058;1085.4518468173521;1105.7125147461718;1107.4462768615692;6038.305594856648;6048.939510604926;6055.7274922628585;6057.666828324396;6117.602355846856;6463;6463.9980802975615;6469.902951455732;6470.22357317125;6471.644059576768;6117.082437634391;6118.082287656798;6128.724207410588;6130.141780150782;6134.44789968896;3451.9654803452145;3480.6693364130365;3484.651534846495;3486.1458942559234;3486.38988177068;6598.769043083469;6731.360520750521;6868.141482314711;6880.69036893341;6886.586804791728;6705.530612857053;6726.22648395431;6737.393634572814;6739.056532085414;6743;6842.7605033824575;6843.315668433117;6846.486513511507;6848.931510684929;6866.107406037283;6567.770128045496;6569.146011018537;6580.407763301135;6580.539362244597;6586.242582103119;6214.223222097238;6398.936010639834;6418.614883107029;6482.6434546098535;6505.0567667688865;6736.73053077891;6772.729090836311;6773.390394864486;6777.390034896883;6780.355866192704;4560.429946256718;4593.655475839392;4597.057603191271;4598.448186217675;4619.676622636383;6524.9673751630935;6531.738730450728;6532.608043517214;6539.084528166156;6541.280459149394;6124.510039196943;6345.206849143857;6364.586301890362;6380.585261958144;6382.744690212339;6313.08460273267;6318.336574659595;6352.968235158794;6394.776182833579;6399.520035997226;6230.190075290365;6230.470410015199;6239.407256310643;6253.874922501615;6292.112366290003;6423.614583125028;6430.228372595318;6433.517486188648;6436.549441539048;6443.7422503101225;6009.158717779427;6063.605865618721;6169.383061693795;6280.057991301159;6286.559940804283 11:01:27 INFO - PROCESS | 4504 | |5;yui.html;792.9643166057526;913.5112714697634;922.2898368256442;927.1331305229609;930.8650245714367;14419.927900360497;15221.086734795907;15315.234238288069;15328.923355383222;15377.84622153778;13837.792433113511;14052.437902483915;14054.297285135728;14058.718825623482;14060.296985150728;560.730849192388;570.1163197044585;573.4294377094776;934.6121359635742;961.0965692249298;956.6603855631255;956.9808603827919;960.5437417226797;961.0341606685272;961.1109723505764;1001.3841487485181;1003.578497031245;1004.437514991607;1004.9447280399612;1006.3307900246364;609.850586606282;628.9716962736665;974.4299584742934;992.4888682328607;1000.0199804191897;735;735.7388127214815;736.0284424559584;737.4211244173351;737.4542838299619;14601.561953141316;14701.632459188499;14706.558803235814;14707;14711.11733295995;14156.575302740832;14218.146911185362;14537.418503259856;14555.636109097251;14618.634534136625;11742;11745.29528228309;11751;11834;11850.466728997217;3870.5355357357016;3972.7219094663387;3982.4424580558743;3990.102226998902;4008.118213992917;50000;51557.48442515564;51604.22593661061;51725;51760;11327.490262938187;11455.198136130392;11458.255213411101;11481.827772583418;11515.424228788695;20257.392278231382;20606.793932060787;20692.172313107607;20717;20734.170633174504;7605.6577454014705;8009.839803203903;8096.7166149184495;8360.58197090143;8709.259712924473;4482.193205223091;4557.521460246693;4635.884102897455;4671.252599584051;4738.0523895221095;3256.853441595134;3258.185453636591;3268.428025095599;3288.095773662262;3293.5059741039036;554.5175697143511;652.1489456259532;653.3238098568054;654.9770758023446;669.8291935556402;631.119588174494;653.4968074582545;711.434409644334;731.2869951796955;770.8959290495711;8699.652013919498;8763.56182190888;8836;9080.22818060459;9539.09378609031;691.8581690753383;698.9091418115714;712.618748969299;723.3598265534935;727.4071631620318;4261.74429534229;4297;4425.557444255549;4463.375127482155;4566.95433045672;53127.468725313025;54419;55057.449425506034;55216.44783552113;55371.723141384035;45191.774041130244;46276.7686161567;46690;47115.05769884652;47189.764051179525;47320.5267947323;47340.763296183984;47683.284750728766;48458;48680.7565962175;8973.50645714492;9002.594883230402;9117.361784675275;9205.217556507772;9221.677241296522;35733.82133089318;35839;36128.63871361253;36725.89822305335;37519.24961500809;41819.581804181566;45368.546314536434;46056.466894321136;46216.537834621224;47123.52876471191;11761.353125578175;11944.76110477803;11986.880131198577;12166.57416990401;12412.689682758004;12666.873331266937;12744.6176614698;12840.55058072963;12930.741385172432;13101.541446049343;12213.450394732436;12365.010799135867;12672.619821405373;12799;13223.735525289632;12403.193792403465;12680.809787853374;12768.170068945488;13151.27667978232;13256.873165781017;12140.575079872162;12237.694057648274;12248.448819802952;12288.38558072075;12313;9690.70927872165;9873;9966.651167209113;10195.133413659922;10267.7433064171;9363.578638961399;9405.95297023538;9437.150656440954;9508.904910950801;9571.952140239255 11:01:27 INFO - PROCESS | 4504 | __end_tp_report 11:01:27 INFO - PROCESS | 4504 | __start_cc_report 11:01:27 INFO - PROCESS | 4504 | _x_x_mozilla_cycle_collect,935 11:01:27 INFO - PROCESS | 4504 | __end_cc_report 11:01:27 INFO - PROCESS | 4504 | __startTimestamp1460656887515__endTimestamp 11:01:27 INFO - PROCESS | 4504 | 11:01:27 INFO - PROCESS | 4504 | ------- Summary: start ------- 11:01:27 INFO - PROCESS | 4504 | Number of tests: 6 11:01:27 INFO - PROCESS | 4504 | 11:01:27 INFO - PROCESS | 4504 | [#0] dojo.html Cycles:165 Average:5283.55 Median:5437.97 stddev:567.11 (10.4%) stddev-sans-first:545.07 11:01:27 INFO - PROCESS | 4504 | Values: 3211.7 3276.5 3287.9 3297.1 3333.2 5227.0 5247.9 5253.2 5263.9 5284.0 5271.1 5275.3 5288.6 5302.6 5330.0 4753.8 4828.9 4845.5 4881.3 4917.4 4865.6 4932.1 4946.3 4956.7 4957.6 4827.4 4882.8 4883.0 4895.9 4930.3 4885.5 4909.4 4914.2 4915.8 4927.3 4759.3 4790.9 4871.2 4877.9 4898.0 5067.8 5078.3 5081.2 5099.6 5155.9 5554.9 5585.7 5610.0 5650.4 5655.8 5714.7 5734.1 5739.4 5756.0 5762.4 5370.5 5386.6 5389.9 5390.4 5393.8 5684.7 5785.5 5869.4 5882.1 5892.0 5593.4 5649.8 5651.1 5652.6 5656.8 5722.7 5737.8 5737.9 5743.1 5745.6 5453.7 5593.7 5728.2 5745.2 5768.1 5652.8 5663.2 5665.0 5669.7 5671.1 4264.4 4361.5 4364.5 4368.7 4386.3 3898.0 3961.1 3976.0 3980.4 4001.9 5374.3 5376.0 5381.1 5382.7 5409.9 5602.9 5663.2 5667.7 5670.2 5761.8 5370.5 5394.4 5395.1 5397.5 5400.9 4795.6 4798.8 4802.5 4806.2 4833.7 5649.2 5800.1 5909.0 5998.6 6011.5 5687.0 5695.5 5703.8 5706.5 5712.6 5845.6 5858.6 5861.2 5864.8 5894.4 5451.7 5560.3 5610.6 5621.6 5625.1 5679.4 5690.8 5701.5 5704.8 5711.9 5386.2 5559.9 5563.2 5563.6 5566.5 5503.6 5563.1 5563.7 5581.9 5602.9 5383.1 5385.3 5390.3 5392.3 5393.4 5438.0 5477.5 5497.3 5532.7 5575.7 5331.4 5455.6 5535.0 5535.7 5608.2 11:01:27 INFO - PROCESS | 4504 | 11:01:27 INFO - PROCESS | 4504 | [#1] ext.html Cycles:180 Average:48814.00 Median:40164.50 stddev:78725.78 (196.0%) stddev-sans-first:78863.21 11:01:27 INFO - PROCESS | 4504 | Values: 547.2 562.9 574.4 595.4 641.3 37537.8 39869.0 39938.2 39947.6 40002.6 43560.0 43925.3 43943.3 44082.6 44341.0 8882.4 9040.1 9106.8 9108.5 9117.1 8728.7 8842.2 8857.4 8866.9 8870.1 9136.7 9192.5 9200.4 9201.1 9203.1 8995.2 9002.9 9057.4 9059.0 9059.5 9169.3 9306.8 9317.6 9320.9 9321.0 43144.8 43602.0 43604.8 43610.8 43627.3 3585.9 3786.6 3800.1 3878.5 4459.2 32530.8 32965.5 33007.7 33069.2 34459.8 4369.7 4371.7 4412.8 4422.4 4443.6 292208.0 292713.0 293528.0 293535.0 294120.0 46028.0 66900.0 67166.7 67226.7 67328.7 44822.8 44932.3 44938.6 44987.0 45087.0 16712.7 16950.0 17008.5 17009.4 17022.1 14196.1 14205.7 14213.9 14286.0 14423.4 15965.3 15991.8 15992.7 15994.5 16029.8 5819.3 5892.4 6024.9 6076.6 6081.7 1010.8 1060.9 1194.3 1204.6 1255.7 30594.7 30643.2 30879.7 31035.8 31185.2 1129.5 1142.6 1238.3 1258.5 1281.5 16141.8 16175.3 16328.0 16424.1 16596.4 310857.0 315944.0 316933.0 318130.0 318493.0 58888.4 59241.1 59288.7 59298.0 59354.0 1269.2 1492.6 1514.1 1557.0 1620.6 29712.4 30458.4 30801.0 33031.0 33074.3 56446.7 57158.0 57364.7 57378.1 57469.0 293884.0 296640.0 296721.0 296903.0 297170.0 34947.0 46060.5 48389.8 48890.0 49124.8 44247.3 44495.3 44574.3 45703.3 49285.3 40127.8 40711.0 40954.4 41093.2 41550.6 39167.0 40048.8 40201.2 40858.0 41217.6 39588.6 39851.8 40071.8 40589.2 40867.2 35204.9 36854.4 37122.0 37155.8 37499.3 27910.7 27997.7 28128.2 28165.2 28388.4 11:01:27 INFO - PROCESS | 4504 | 11:01:27 INFO - PROCESS | 4504 | [#2] jquery.html Cycles:180 Average:26053.56 Median:2444.20 stddev:73319.11 (2999.7%) stddev-sans-first:73499.46 11:01:27 INFO - PROCESS | 4504 | Values: 386.9 389.9 395.8 400.7 402.5 17166.4 19241.2 19424.8 19622.0 19712.5 17525.6 17559.3 18112.7 18221.7 18241.0 5646.7 5796.4 5801.9 5839.7 5840.9 4199.0 6048.6 6288.5 6311.8 6315.3 6145.8 6258.6 6259.2 6290.9 6299.7 6411.2 6419.8 6436.3 6441.7 6442.5 3853.1 5376.2 5574.0 5575.4 5590.5 20130.3 20247.2 20843.9 22051.9 22108.8 2237.6 2374.3 2514.1 2598.6 3120.1 13219.9 13768.2 13815.2 14062.6 14228.8 1968.5 2004.5 2020.4 2024.3 2045.1 64933.7 64995.0 65012.3 66049.0 66849.0 9766.1 9860.1 9877.5 10215.0 10327.2 12946.5 12967.4 13042.0 13101.7 13114.0 8004.0 8063.5 8126.2 8127.9 8144.8 8149.5 8161.4 8196.6 8317.8 8329.1 6032.8 6172.6 6193.4 6217.8 6272.7 1671.4 1834.1 1892.3 1909.1 1919.5 941.0 1054.0 1069.3 1085.9 1149.7 17462.7 17625.3 17756.3 17956.6 18267.1 974.6 987.6 1025.6 1057.3 1063.4 10265.9 10300.1 10513.7 10545.4 10783.1 433572.0 437801.0 451849.0 454835.0 464484.0 66810.0 67213.7 67994.7 68824.3 69422.3 1071.7 1086.0 1091.1 1093.2 1103.4 15739.6 15958.0 16034.4 16057.2 16141.4 32155.2 32211.8 32479.2 33035.3 33896.8 45321.5 45916.3 45963.0 46142.3 46368.5 8365.0 8461.5 8586.8 8632.5 8808.1 12999.2 13127.1 13173.5 13222.4 13275.4 10736.8 10987.2 11098.8 11734.3 11852.0 11375.8 11463.9 11488.5 11737.8 11959.9 11331.1 11424.8 11445.6 11624.7 11666.9 8151.5 8228.7 8297.8 8309.7 8412.6 11355.6 11520.5 11582.2 11597.2 11604.9 11:01:27 INFO - PROCESS | 4504 | 11:01:27 INFO - PROCESS | 4504 | [#3] mootools.html Cycles:180 Average:6004.36 Median:5375.52 stddev:3183.22 (59.2%) stddev-sans-first:3172.35 11:01:27 INFO - PROCESS | 4504 | Values: 1281.9 1599.9 1601.5 1863.9 1953.9 8140.6 8321.7 8326.1 8334.6 8341.9 8396.2 8534.6 8589.4 8589.7 8598.9 2112.0 2389.0 2413.3 2424.8 2486.6 2455.7 2483.0 2489.3 2489.4 2492.6 2438.9 2458.8 2470.3 2470.4 2472.0 2372.2 2381.5 2396.3 2399.8 2400.2 2383.3 2383.9 2393.3 2443.4 2444.4 8635.4 8662.8 8692.4 8699.0 8716.7 5146.5 5256.9 5261.7 5303.0 5305.5 3274.4 3292.0 3358.5 3363.2 3368.0 1070.7 1080.3 1087.3 1090.8 1119.5 12039.9 12088.6 12088.9 12090.7 12095.8 4652.1 4704.1 4773.5 4790.8 4806.8 10201.7 10210.1 10210.5 10210.7 10219.0 4576.3 5374.7 5376.4 5378.4 5381.5 4761.4 4797.8 4862.0 4873.0 4873.6 3873.1 3973.1 3980.7 3994.3 4026.7 1302.6 1318.8 1323.2 1330.4 1333.7 1434.7 1447.4 1449.5 1460.8 1482.1 7972.8 8015.0 8034.2 8073.3 8088.3 543.3 545.7 551.2 553.4 553.8 6029.5 6052.3 6054.4 6117.3 6134.6 10376.2 10571.9 10590.3 10715.7 10745.0 9814.8 10327.0 10469.6 10513.4 10553.8 7961.8 8058.0 8081.6 8107.5 8169.0 7801.1 7808.9 7886.1 7909.2 7957.2 9188.4 9217.2 9260.2 9312.2 9440.0 9577.5 9652.4 9669.4 9743.5 9977.0 6692.3 7605.6 7724.1 7802.8 8038.5 8093.9 8185.1 8190.6 8205.0 8222.0 7294.9 7452.7 7459.1 7611.6 7618.0 7343.0 7391.6 7410.3 7500.5 7512.8 7722.5 7723.4 7739.9 7789.5 7792.5 6970.0 7080.2 7100.3 7101.5 7140.9 7166.7 7295.1 7333.1 7361.6 7365.7 11:01:27 INFO - PROCESS | 4504 | 11:01:27 INFO - PROCESS | 4504 | [#4] prototype.html Cycles:180 Average:5324.72 Median:6023.73 stddev:1582.95 (26.3%) stddev-sans-first:1543.01 11:01:27 INFO - PROCESS | 4504 | Values: 366.1 368.5 372.4 374.1 374.8 5888.0 5920.8 5925.3 5934.4 5996.6 5902.9 5920.1 5921.9 5925.4 5936.5 4457.7 4544.6 4666.1 4670.1 4708.1 4663.2 4665.2 4684.1 4684.7 4688.7 4644.8 4658.9 4661.1 4662.7 4664.9 4391.7 4482.5 4596.7 4627.9 4643.3 4125.8 4129.4 4129.6 4131.6 4139.6 5643.1 5650.2 5656.4 5659.7 5666.7 5388.9 5402.1 5407.2 5413.6 5413.9 6251.0 6269.0 6269.2 6269.7 6276.9 4352.1 4473.6 4508.1 4517.0 4568.3 6519.8 6544.7 6636.1 6645.8 6653.9 4581.4 4585.0 4586.3 4586.7 4589.0 4650.2 4654.7 4656.9 4657.2 4659.4 5324.3 5330.7 5331.2 5333.8 5338.1 6155.4 6193.1 6285.6 6288.1 6341.2 1609.2 1609.2 1613.9 1623.4 1630.9 1028.7 1078.7 1085.5 1105.7 1107.4 6038.3 6048.9 6055.7 6057.7 6117.6 6463.0 6464.0 6469.9 6470.2 6471.6 6117.1 6118.1 6128.7 6130.1 6134.4 3452.0 3480.7 3484.7 3486.1 3486.4 6598.8 6731.4 6868.1 6880.7 6886.6 6705.5 6726.2 6737.4 6739.1 6743.0 6842.8 6843.3 6846.5 6848.9 6866.1 6567.8 6569.1 6580.4 6580.5 6586.2 6214.2 6398.9 6418.6 6482.6 6505.1 6736.7 6772.7 6773.4 6777.4 6780.4 4560.4 4593.7 4597.1 4598.4 4619.7 6525.0 6531.7 6532.6 6539.1 6541.3 6124.5 6345.2 6364.6 6380.6 6382.7 6313.1 6318.3 6353.0 6394.8 6399.5 6230.2 6230.5 6239.4 6253.9 6292.1 6423.6 6430.2 6433.5 6436.5 6443.7 6009.2 6063.6 6169.4 6280.1 6286.6 11:01:27 INFO - PROCESS | 4504 | 11:01:27 INFO - PROCESS | 4504 | [#5] yui.html Cycles:180 Average:14332.58 Median:24963.03 stddev:15755.35 (63.1%) stddev-sans-first:15766.73 11:01:27 INFO - PROCESS | 4504 | Values: 793.0 913.5 922.3 927.1 930.9 14419.9 15221.1 15315.2 15328.9 15377.8 13837.8 14052.4 14054.3 14058.7 14060.3 560.7 570.1 573.4 934.6 961.1 956.7 957.0 960.5 961.0 961.1 1001.4 1003.6 1004.4 1004.9 1006.3 609.9 629.0 974.4 992.5 1000.0 735.0 735.7 736.0 737.4 737.5 14601.6 14701.6 14706.6 14707.0 14711.1 14156.6 14218.1 14537.4 14555.6 14618.6 11742.0 11745.3 11751.0 11834.0 11850.5 3870.5 3972.7 3982.4 3990.1 4008.1 50000.0 51557.5 51604.2 51725.0 51760.0 11327.5 11455.2 11458.3 11481.8 11515.4 20257.4 20606.8 20692.2 20717.0 20734.2 7605.7 8009.8 8096.7 8360.6 8709.3 4482.2 4557.5 4635.9 4671.3 4738.1 3256.9 3258.2 3268.4 3288.1 3293.5 554.5 652.1 653.3 655.0 669.8 631.1 653.5 711.4 731.3 770.9 8699.7 8763.6 8836.0 9080.2 9539.1 691.9 698.9 712.6 723.4 727.4 4261.7 4297.0 4425.6 4463.4 4567.0 53127.5 54419.0 55057.4 55216.4 55371.7 45191.8 46276.8 46690.0 47115.1 47189.8 47320.5 47340.8 47683.3 48458.0 48680.8 8973.5 9002.6 9117.4 9205.2 9221.7 35733.8 35839.0 36128.6 36725.9 37519.2 41819.6 45368.5 46056.5 46216.5 47123.5 11761.4 11944.8 11986.9 12166.6 12412.7 12666.9 12744.6 12840.6 12930.7 13101.5 12213.5 12365.0 12672.6 12799.0 13223.7 12403.2 12680.8 12768.2 13151.3 13256.9 12140.6 12237.7 12248.4 12288.4 12313.0 9690.7 9873.0 9966.7 10195.1 10267.7 9363.6 9406.0 9437.2 9508.9 9572.0 11:01:27 INFO - PROCESS | 4504 | -------- Summary: end -------- 11:01:27 INFO - PROCESS | 4504 | 11:01:28 INFO - TEST-INFO | 4504: exit 0 11:01:28 INFO - TEST-OK | dromaeo_css | took 1112072ms 11:01:28 INFO - TEST-START | kraken 11:01:28 INFO - operating with platform_type : linux_ 11:01:28 INFO - Initialising browser for kraken test... 11:01:28 INFO - TEST-INFO | started process 4699 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpV8ZOMt/profile http://localhost:48016/getInfo.html) 11:01:33 INFO - PROCESS | 4699 | __metrics Screen width/height:1600/1200 11:01:33 INFO - PROCESS | 4699 | colorDepth:24 11:01:33 INFO - PROCESS | 4699 | Browser inner width/height: 1024/697 11:01:33 INFO - PROCESS | 4699 | __metrics 11:01:34 INFO - PROCESS | 4699 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:01:35 INFO - TEST-INFO | 4699: exit 0 11:01:35 INFO - Browser initialized. 11:01:35 INFO - Running cycle 1/1 for kraken test... 11:01:35 INFO - TEST-INFO | started process 4786 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpV8ZOMt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:01:46 INFO - PROCESS | 4786 | RSS: Main: 141279232 11:01:46 INFO - PROCESS | 4786 | 11:01:49 INFO - PROCESS | 4786 | Cycle 1(1): loaded http://localhost:48016/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48016/tests/kraken/driver.html?testName=audio-beat-detection) 11:01:49 INFO - PROCESS | 4786 | RSS: Main: 178176000 11:01:49 INFO - PROCESS | 4786 | 11:01:52 INFO - PROCESS | 4786 | Cycle 1(1): loaded http://localhost:48016/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48016/tests/kraken/driver.html?testName=audio-dft) 11:01:53 INFO - PROCESS | 4786 | RSS: Main: 175063040 11:01:53 INFO - PROCESS | 4786 | 11:01:55 INFO - PROCESS | 4786 | Cycle 1(1): loaded http://localhost:48016/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48016/tests/kraken/driver.html?testName=audio-fft) 11:01:56 INFO - PROCESS | 4786 | RSS: Main: 173195264 11:01:56 INFO - PROCESS | 4786 | 11:01:58 INFO - PROCESS | 4786 | Cycle 1(1): loaded http://localhost:48016/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48016/tests/kraken/driver.html?testName=audio-oscillator) 11:01:59 INFO - PROCESS | 4786 | RSS: Main: 174129152 11:01:59 INFO - PROCESS | 4786 | 11:02:01 INFO - PROCESS | 4786 | Cycle 1(1): loaded http://localhost:48016/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48016/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:02:01 INFO - PROCESS | 4786 | RSS: Main: 172068864 11:02:01 INFO - PROCESS | 4786 | 11:02:04 INFO - PROCESS | 4786 | Cycle 1(1): loaded http://localhost:48016/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48016/tests/kraken/driver.html?testName=imaging-darkroom) 11:02:05 INFO - PROCESS | 4786 | RSS: Main: 171941888 11:02:05 INFO - PROCESS | 4786 | 11:02:08 INFO - PROCESS | 4786 | Cycle 1(1): loaded http://localhost:48016/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48016/tests/kraken/driver.html?testName=imaging-desaturate) 11:02:09 INFO - PROCESS | 4786 | RSS: Main: 172007424 11:02:09 INFO - PROCESS | 4786 | 11:02:12 INFO - PROCESS | 4786 | Cycle 1(1): loaded http://localhost:48016/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48016/tests/kraken/driver.html?testName=json-parse-financial) 11:02:12 INFO - PROCESS | 4786 | RSS: Main: 172728320 11:02:12 INFO - PROCESS | 4786 | 11:02:14 INFO - PROCESS | 4786 | Cycle 1(1): loaded http://localhost:48016/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48016/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:02:14 INFO - PROCESS | 4786 | RSS: Main: 176349184 11:02:14 INFO - PROCESS | 4786 | 11:02:16 INFO - PROCESS | 4786 | Cycle 1(1): loaded http://localhost:48016/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48016/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:02:17 INFO - PROCESS | 4786 | RSS: Main: 174514176 11:02:17 INFO - PROCESS | 4786 | 11:02:19 INFO - PROCESS | 4786 | Cycle 1(1): loaded http://localhost:48016/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48016/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:02:19 INFO - PROCESS | 4786 | RSS: Main: 180346880 11:02:19 INFO - PROCESS | 4786 | 11:02:22 INFO - PROCESS | 4786 | Cycle 1(1): loaded http://localhost:48016/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48016/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:02:22 INFO - PROCESS | 4786 | RSS: Main: 187813888 11:02:22 INFO - PROCESS | 4786 | 11:02:25 INFO - PROCESS | 4786 | Cycle 1(1): loaded http://localhost:48016/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48016/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:02:25 INFO - PROCESS | 4786 | RSS: Main: 188235776 11:02:25 INFO - PROCESS | 4786 | 11:02:27 INFO - PROCESS | 4786 | Cycle 1(1): loaded http://localhost:48016/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48016/tests/kraken/driver.html?testName=ai-astar) 11:02:27 INFO - PROCESS | 4786 | RSS: Main: 249511936 11:02:27 INFO - PROCESS | 4786 | 11:02:27 INFO - PROCESS | 4786 | __start_tp_report 11:02:27 INFO - PROCESS | 4786 | _x_x_mozilla_page_load 11:02:27 INFO - PROCESS | 4786 | _x_x_mozilla_page_load_details 11:02:27 INFO - PROCESS | 4786 | |i|pagename|runs| 11:02:27 INFO - PROCESS | 4786 | |0;ai-astar;108;109;106;109;110;108;98;108;109;109 11:02:27 INFO - PROCESS | 4786 | |1;audio-beat-detection;163;127;157;171;128;160;160;128;176;128 11:02:27 INFO - PROCESS | 4786 | |2;audio-dft;159;161;161;160;162;160;160;165;160;162 11:02:27 INFO - PROCESS | 4786 | |3;audio-fft;76;76;74;170;77;77;74;74;165;75 11:02:27 INFO - PROCESS | 4786 | |4;audio-oscillator;93;93;151;93;93;93;143;93;93;139 11:02:27 INFO - PROCESS | 4786 | |5;imaging-gaussian-blur;118;117;117;117;117;117;117;117;117;117 11:02:27 INFO - PROCESS | 4786 | |6;imaging-darkroom;148;146;146;145;147;146;145;146;148;145 11:02:27 INFO - PROCESS | 4786 | |7;imaging-desaturate;96;96;96;96;96;95;95;96;95;96 11:02:27 INFO - PROCESS | 4786 | |8;json-parse-financial;54;54;55;55;54;54;55;63;52;52 11:02:27 INFO - PROCESS | 4786 | |9;json-stringify-tinderbox;65;65;64;65;64;65;65;64;64;65 11:02:27 INFO - PROCESS | 4786 | |10;stanford-crypto-aes;84;78;79;78;78;77;76;78;77;78 11:02:27 INFO - PROCESS | 4786 | |11;stanford-crypto-ccm;120;119;118;114;114;112;110;120;112;117 11:02:27 INFO - PROCESS | 4786 | |12;stanford-crypto-pbkdf2;145;144;155;145;155;137;145;142;133;144 11:02:27 INFO - PROCESS | 4786 | |13;stanford-crypto-sha256-iterative;67;66;69;70;67;67;68;69;70;65 11:02:27 INFO - PROCESS | 4786 | __end_tp_report 11:02:27 INFO - PROCESS | 4786 | __start_cc_report 11:02:27 INFO - PROCESS | 4786 | _x_x_mozilla_cycle_collect,1064 11:02:27 INFO - PROCESS | 4786 | __end_cc_report 11:02:27 INFO - PROCESS | 4786 | __startTimestamp1460656947898__endTimestamp 11:02:27 INFO - PROCESS | 4786 | 11:02:27 INFO - PROCESS | 4786 | ------- Summary: start ------- 11:02:27 INFO - PROCESS | 4786 | Number of tests: 14 11:02:27 INFO - PROCESS | 4786 | 11:02:27 INFO - PROCESS | 4786 | [#0] ai-astar Cycles:10 Average:107.40 Median:109.00 stddev:3.47 (3.2%) stddev-sans-first:3.67 11:02:27 INFO - PROCESS | 4786 | Values: 108.0 109.0 106.0 109.0 110.0 108.0 98.0 108.0 109.0 109.0 11:02:27 INFO - PROCESS | 4786 | 11:02:27 INFO - PROCESS | 4786 | [#1] audio-beat-detection Cycles:10 Average:149.80 Median:160.00 stddev:19.76 (12.4%) stddev-sans-first:20.38 11:02:27 INFO - PROCESS | 4786 | Values: 163.0 127.0 157.0 171.0 128.0 160.0 160.0 128.0 176.0 128.0 11:02:27 INFO - PROCESS | 4786 | 11:02:27 INFO - PROCESS | 4786 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.70 (1.1%) stddev-sans-first:1.64 11:02:27 INFO - PROCESS | 4786 | Values: 159.0 161.0 161.0 160.0 162.0 160.0 160.0 165.0 160.0 162.0 11:02:27 INFO - PROCESS | 4786 | 11:02:27 INFO - PROCESS | 4786 | [#3] audio-fft Cycles:10 Average:93.80 Median:75.50 stddev:38.88 (51.5%) stddev-sans-first:40.70 11:02:27 INFO - PROCESS | 4786 | Values: 76.0 76.0 74.0 170.0 77.0 77.0 74.0 74.0 165.0 75.0 11:02:27 INFO - PROCESS | 4786 | 11:02:27 INFO - PROCESS | 4786 | [#4] audio-oscillator Cycles:10 Average:108.40 Median:93.00 stddev:24.96 (26.8%) stddev-sans-first:25.85 11:02:27 INFO - PROCESS | 4786 | Values: 93.0 93.0 151.0 93.0 93.0 93.0 143.0 93.0 93.0 139.0 11:02:27 INFO - PROCESS | 4786 | 11:02:27 INFO - PROCESS | 4786 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 11:02:27 INFO - PROCESS | 4786 | Values: 118.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 11:02:27 INFO - PROCESS | 4786 | 11:02:27 INFO - PROCESS | 4786 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:1.14 (0.8%) stddev-sans-first:1.00 11:02:27 INFO - PROCESS | 4786 | Values: 148.0 146.0 146.0 145.0 147.0 146.0 145.0 146.0 148.0 145.0 11:02:27 INFO - PROCESS | 4786 | 11:02:27 INFO - PROCESS | 4786 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 11:02:27 INFO - PROCESS | 4786 | Values: 96.0 96.0 96.0 96.0 96.0 95.0 95.0 96.0 95.0 96.0 11:02:27 INFO - PROCESS | 4786 | 11:02:27 INFO - PROCESS | 4786 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:54.50 stddev:3.08 (5.7%) stddev-sans-first:3.26 11:02:27 INFO - PROCESS | 4786 | Values: 54.0 54.0 55.0 55.0 54.0 54.0 55.0 63.0 52.0 52.0 11:02:27 INFO - PROCESS | 4786 | 11:02:27 INFO - PROCESS | 4786 | [#9] json-stringify-tinderbox Cycles:10 Average:64.60 Median:65.00 stddev:0.52 (0.8%) stddev-sans-first:0.53 11:02:27 INFO - PROCESS | 4786 | Values: 65.0 65.0 64.0 65.0 64.0 65.0 65.0 64.0 64.0 65.0 11:02:27 INFO - PROCESS | 4786 | 11:02:27 INFO - PROCESS | 4786 | [#10] stanford-crypto-aes Cycles:10 Average:78.30 Median:78.00 stddev:2.16 (2.8%) stddev-sans-first:0.87 11:02:27 INFO - PROCESS | 4786 | Values: 84.0 78.0 79.0 78.0 78.0 77.0 76.0 78.0 77.0 78.0 11:02:27 INFO - PROCESS | 4786 | 11:02:27 INFO - PROCESS | 4786 | [#11] stanford-crypto-ccm Cycles:10 Average:115.60 Median:117.50 stddev:3.66 (3.1%) stddev-sans-first:3.52 11:02:27 INFO - PROCESS | 4786 | Values: 120.0 119.0 118.0 114.0 114.0 112.0 110.0 120.0 112.0 117.0 11:02:27 INFO - PROCESS | 4786 | 11:02:27 INFO - PROCESS | 4786 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.50 Median:145.00 stddev:6.80 (4.7%) stddev-sans-first:7.21 11:02:27 INFO - PROCESS | 4786 | Values: 145.0 144.0 155.0 145.0 155.0 137.0 145.0 142.0 133.0 144.0 11:02:27 INFO - PROCESS | 4786 | 11:02:27 INFO - PROCESS | 4786 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.50 stddev:1.69 (2.5%) stddev-sans-first:1.76 11:02:27 INFO - PROCESS | 4786 | Values: 67.0 66.0 69.0 70.0 67.0 67.0 68.0 69.0 70.0 65.0 11:02:27 INFO - PROCESS | 4786 | -------- Summary: end -------- 11:02:27 INFO - PROCESS | 4786 | 11:02:28 INFO - TEST-INFO | 4786: exit 0 11:02:28 INFO - TEST-OK | kraken | took 60557ms 11:02:28 INFO - SUITE-END | took 1172s 11:02:29 INFO - Completed test suite (00:19:32) 11:02:29 INFO - javascript benchmark 11:02:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3211.7270032047277, 3276.459384201607, 3287.9178020549484, 3297.0603378037263, 3333.200031992321, 5227.0, 5247.947520524794, 5253.185756207789, 5263.947360526398, 5284.048871203182, 5271.051210782058, 5275.261463395118, 5288.576913846892, 5302.602304827144, 5330.040592693314, 4753.786079626425, 4828.879278018051, 4845.466998630165, 4881.267809828519, 4917.385326834145, 4865.635077369211, 4932.062908047459, 4946.332245146913, 4956.7025978441225, 4957.5786058185095, 4827.372441582607, 4882.829100981467, 4883.0, 4895.902081958358, 4930.285108659242, 4885.5358740919555, 4909.361782968227, 4914.238293064581, 4915.754212289371, 4927.260910863363, 4759.333693282943, 4790.94599188178, 4871.244957031666, 4877.926831097537, 4898.020395920795, 5067.847964561069, 5078.263651770472, 5081.161608334621, 5099.566536844335, 5155.9484405155845, 5554.888902221974, 5585.664860108406, 5609.9902017636805, 5650.378458369576, 5655.802046928379, 5714.685692286923, 5734.082546792535, 5739.426057394269, 5755.971220143914, 5762.366139724627, 5370.462953704638, 5386.649867758622, 5389.946100539023, 5390.353157621072, 5393.7572809223675, 5684.744186511617, 5785.479306862402, 5869.383714709979, 5882.117682347596, 5892.027815410495, 5593.412691667398, 5649.774009039593, 5651.124075768263, 5652.576056795757, 5656.773729050874, 5722.7424765885635, 5737.827865164052, 5737.8565535861935, 5743.10981797822, 5745.569082318842, 5453.672779633234, 5593.664380137205, 5728.169415434739, 5745.1669507921115, 5768.105943578752, 5652.773889044474, 5663.150527420919, 5664.971675141598, 5669.688167150846, 5671.092625179951, 4264.360345948071, 4361.542038085955, 4364.454443194601, 4368.672349573794, 4386.298192289219, 3898.0254936265933, 3961.1087505311652, 3976.0258736609717, 3980.44273801668, 4001.9399709004388, 5374.274472946102, 5375.973120134374, 5381.0583147948955, 5382.67703937765, 5409.891802163935, 5602.887942241214, 5663.235463212496, 5667.716614169275, 5670.177824215466, 5761.827145185651, 5370.4629537045985, 5394.352677678625, 5395.05586522357, 5397.487238712316, 5400.864978375572, 4795.640326975491, 4798.832040878552, 4802.495737947535, 4806.182948898696, 4833.709977401367, 5649.237352957381, 5800.100984347433, 5909.0, 5998.610090344114, 6011.549133814981, 5687.03320435527, 5695.515881149983, 5703.828885133453, 5706.457886500776, 5712.6286791358425, 5845.649261044181, 5858.5898987070495, 5861.1794348792055, 5864.794732184524, 5894.440028197314, 5451.727413629382, 5560.277163968658, 5610.6072574921, 5621.578381621476, 5625.071863142535, 5679.37526872052, 5690.829275121753, 5701.458361455655, 5704.80033198836, 5711.942880571141, 5386.245925570502, 5559.861003474945, 5563.221149039056, 5563.610547261653, 5566.526845218202, 5503.614746967673, 5563.082091454865, 5563.7496312666835, 5581.9162712560155, 5602.887942241051, 5383.084875571084, 5385.3268341457315, 5390.272313237662, 5392.325959255093, 5393.379761327341, 5437.972810135924, 5477.452254774491, 5497.257870187634, 5532.668039917457, 5575.749091290821, 5331.360236771612, 5455.590830687794, 5534.972325138348, 5535.667859928417, 5608.214849921096], "unit": "score", "name": "dojo.html", "value": 5248.43686606542}, {"lowerIsBetter": false, "replicates": [547.2256756689285, 562.9465200805922, 574.3768011707298, 595.3599880128861, 641.304184959319, 37537.81231093844, 39869.0, 39938.201235975335, 39947.60052399475, 40002.59997400025, 43560.0, 43925.341119883225, 43943.340849887194, 44082.55917440825, 44341.0, 8882.37823352364, 9040.141186587263, 9106.817863642724, 9108.499032553207, 9117.088291170863, 8728.694495692653, 8842.248408885253, 8857.379983401164, 8866.86699699505, 8870.112988701143, 9136.725898223063, 9192.494412807293, 9200.401973871676, 9201.125893040151, 9203.125703058198, 8995.235404990552, 9002.909970900273, 9057.411268267542, 9058.954705226432, 9059.50172740499, 9169.266458683289, 9306.767330816716, 9317.627294908263, 9320.8601870972, 9321.021292764297, 43144.78427607873, 43602.0, 43604.781976089915, 43610.781946090385, 43627.34558981618, 3585.928281434383, 3786.583475817658, 3800.1449673823445, 3878.495795546561, 4459.175052615276, 32530.83734581312, 32965.50551741726, 33007.6699233007, 33069.18911892492, 34459.827700861584, 4369.694121411502, 4371.737695738266, 4412.845550405753, 4422.402975598286, 4443.622292105175, 292208.0, 292713.0, 293528.0, 293534.99999999785, 294120.0, 46028.0, 66900.0, 67166.66416667885, 67226.66386668134, 67328.66335668389, 44822.77588612036, 44932.3260151098, 44938.55061449409, 44987.0, 45087.0, 16712.665746684997, 16950.0, 17008.48974530766, 17009.404670836462, 17022.148892555324, 14196.148231106166, 14205.715885682228, 14213.857861421253, 14285.9999800013, 14423.42306307757, 15965.281562329723, 15991.760123598155, 15992.680146397008, 15994.520164395086, 16029.839701602834, 5819.301683797887, 5892.351841297454, 6024.8795024100145, 6076.605020673642, 6081.695915204222, 1010.8433192855119, 1060.9151267898549, 1194.325206258461, 1204.6093730555867, 1255.6609715376796, 30594.69405305963, 30643.233919151753, 30879.69120308768, 31035.84482077575, 31185.22036949049, 1129.48043899807, 1142.5943789954447, 1238.3189245914712, 1258.4651523102646, 1281.5450515067203, 16141.757873631905, 16175.272112754954, 16328.0, 16424.09667468277, 16596.419125330554, 310857.0, 315944.0, 316933.0, 318130.0, 318493.0, 58888.41111588915, 59241.111383329284, 59288.70355648194, 59298.0, 59354.0, 1269.2321145706899, 1492.6193820575684, 1514.0612820051638, 1557.0424189123607, 1620.586750378646, 29712.40575188441, 30458.390832183675, 30801.0, 33031.0, 33074.33851323008, 56446.717766410904, 57158.0, 57364.71317643385, 57378.13932791095, 57469.0, 293884.0, 296640.0, 296721.0, 296903.0, 297170.0, 34947.0, 46060.53939460697, 48389.758051209516, 48890.0, 49124.75437622789, 44247.336289955034, 44495.332570010825, 44574.3313850299, 45703.31445028261, 49285.260721088496, 40127.79936100301, 40710.982225444604, 40954.385684215355, 41093.1781364377, 41550.58449415588, 39167.0, 40048.79975600103, 40201.1959760809, 40858.0, 41217.58782412257, 39588.60411395849, 39851.80074099611, 40071.799641001606, 40589.1882162361, 40867.182656346115, 35204.887706737674, 36854.44718329281, 37122.0, 37155.814220928725, 37499.25001500009, 27910.72089279081, 27997.720022800328, 28128.156155315373, 28165.15504534867, 28388.43223135567], "unit": "score", "name": "ext.html", "value": 19754.327366382506}, {"lowerIsBetter": false, "replicates": [386.92068126034155, 389.8674450686768, 395.7922090902278, 400.6534347789162, 402.54713447371705, 17166.39917602884, 19241.23035078597, 19424.805751942476, 19622.0, 19712.507187320305, 17525.561860953483, 17559.29762809486, 18112.72830907534, 18221.7266740999, 18241.0, 5646.661200327983, 5796.362400135981, 5801.9129713054335, 5839.678817665027, 5840.853978650525, 4199.0, 6048.576599638027, 6288.465480434169, 6311.810645680637, 6315.336889626569, 6145.754169833223, 6258.593191442542, 6259.155014073087, 6290.905636415458, 6299.716512756937, 6411.166548348685, 6419.8395040123905, 6436.259830119549, 6441.6779161041995, 6442.549021568492, 3853.113783829735, 5376.193570964348, 5574.0, 5575.414581468968, 5590.496855283044, 20130.295439659687, 20247.190112395485, 20843.89578052115, 22051.889740551356, 22108.778912210993, 2237.5524895021063, 2374.3351861478814, 2514.0697941761664, 2598.610208468726, 3120.0951724000015, 13219.86780132196, 13768.24274664893, 13815.171089734547, 14062.578122656336, 14228.786568201485, 1968.5472341361424, 2004.488855341893, 2020.444377796103, 2024.3016159424974, 2045.1001559313854, 64933.67533162351, 64995.0, 65012.3498765011, 66049.0, 66849.0, 9766.121049105615, 9860.112589866947, 9877.506124693737, 10215.0, 10327.225458090674, 12946.482140714266, 12967.351632418342, 13042.0, 13101.737965240642, 13114.01644876619, 8003.9599802001785, 8063.475874068166, 8126.228008339198, 8127.878081828777, 8144.75565733029, 8149.51102933814, 8161.387895907831, 8196.631151598192, 8317.8336433271, 8329.08380078191, 6032.758689652364, 6172.598781079216, 6193.4425901669065, 6217.751289948442, 6272.655003974825, 1671.4317132174876, 1834.067657381829, 1892.2903911033363, 1909.1313452379134, 1919.5009297582728, 940.9905900941039, 1054.0, 1069.3316677076828, 1085.8914108589079, 1149.7183190118474, 17462.738058929128, 17625.294988200327, 17756.289748410178, 17956.640867182585, 18267.086645667663, 974.6247694637474, 987.6493844685033, 1025.5846382215216, 1057.2968975631272, 1063.4363787192801, 10265.948670256601, 10300.124489418484, 10513.737156571147, 10545.367277963347, 10783.083437907866, 433572.0, 437801.0, 451849.0, 454835.0, 464484.0, 66810.0, 67213.66393168003, 67994.66002670054, 68824.31175688279, 69422.30577694159, 1071.7320669832543, 1085.9728506787394, 1091.0998426298336, 1093.1528065748948, 1103.420704130338, 15739.606509836887, 15958.0, 16034.358625654842, 16057.19714014318, 16141.435049773201, 32155.196120097185, 32211.838940806083, 32479.18802029968, 33035.339293214485, 33896.830515847265, 45321.54678453305, 45916.311255331864, 45963.0, 46142.30786538272, 46368.53631463777, 8365.0, 8461.534615596202, 8586.828263434822, 8632.525211113449, 8808.11918808114, 12999.1550549214, 13127.081104322606, 13173.473061077833, 13222.404991775586, 13275.402606882906, 10736.838947415952, 10987.175961803057, 11098.833517497082, 11734.295942243492, 11852.0, 11375.829362559403, 11463.942680286546, 11488.48301826403, 11737.823932640846, 11959.940200298943, 11331.093512519143, 11424.82862757076, 11445.599404020819, 11624.709382265512, 11666.88333116658, 8151.5109093454585, 8228.670853166046, 8297.792555186168, 8309.709160179365, 8412.62143203545, 11355.602553910574, 11520.539178433104, 11582.189246752983, 11597.18819682614, 11604.88395116038], "unit": "score", "name": "jquery.html", "value": 9020.9844229702}, {"lowerIsBetter": false, "replicates": [1281.8974482041438, 1599.8880078394513, 1601.4555051282562, 1863.9068046597674, 1953.9316123935664, 8140.592970351481, 8321.708740194095, 8326.084130745621, 8334.624941877615, 8341.91658083419, 8396.160383961616, 8534.57327133644, 8589.398742088057, 8589.742307730763, 8598.91401085989, 2111.978880211201, 2388.988055059727, 2413.3242692046256, 2424.7696468835434, 2486.589712697412, 2455.7175924768703, 2482.9751702482927, 2489.3403248139257, 2489.4149874779414, 2492.6011838105906, 2438.902443902242, 2458.8278820482574, 2470.3083136721657, 2470.4441500662388, 2471.962920556184, 2372.240882917467, 2381.5475059738683, 2396.2691379129446, 2399.8440101393353, 2400.2079313826393, 2383.3088404362716, 2383.9391470795504, 2393.3366310414267, 2443.389152711822, 2444.4377793107683, 8635.39552231344, 8662.826743465159, 8692.391532592721, 8699.043105258417, 8716.694915677921, 5146.536811686966, 5256.92114618281, 5261.657992230493, 5302.973485132588, 5305.522502974751, 3274.3778682050333, 3291.983540082308, 3358.4794356874722, 3363.226457914669, 3367.983160084184, 1070.68414817629, 1080.2924084724518, 1087.255230167338, 1090.841827934945, 1119.5074167366333, 12039.93980030103, 12088.576899808464, 12088.879111208864, 12090.697732556668, 12095.758084838342, 4652.092841895797, 4704.1062198182235, 4773.474917759044, 4790.760461976957, 4806.759662016885, 10201.693949181536, 10210.081092701692, 10210.540525676362, 10210.693679189637, 10219.029192226726, 4576.290674945389, 5374.6506477078865, 5376.381716102698, 5378.435264297271, 5381.48875856793, 4761.381020467386, 4797.832075877328, 4862.027594481118, 4873.049755297754, 4873.634477414208, 3873.070463088895, 3973.0663294125857, 3980.681545476355, 3994.261061703536, 4026.7382620129597, 1302.6482849630547, 1318.7626227279181, 1323.1928523600595, 1330.374723879775, 1333.6532501549666, 1434.6628542292553, 1447.4499690117689, 1449.54339383094, 1460.8173978252719, 1482.1255459279078, 7972.840543189103, 8014.959925200454, 8034.196580341919, 8073.273405393543, 8088.272055514914, 543.2855794630049, 545.6507834985613, 551.1677367175594, 553.3608681972329, 553.8366181976327, 6029.487493563009, 6052.303985041688, 6054.39456054391, 6117.265928088569, 6134.601250918676, 10376.221783366278, 10571.94714026425, 10590.311629744043, 10715.732106697238, 10745.0, 9814.754631134136, 10327.0, 10469.633562825264, 10513.369197848153, 10553.84169237462, 7961.761147165595, 8057.959710201529, 8081.555514446644, 8107.473014254055, 8169.0, 7801.063872335356, 7808.88286675689, 7886.05367355898, 7909.24862138096, 7957.244061814118, 9188.448693078437, 9217.170454659114, 9260.212881905114, 9312.161905428544, 9440.0, 9577.521123943914, 9652.372595781251, 9669.371490853073, 9743.512824358611, 9976.950115249378, 6692.263850976486, 7605.619719013916, 7724.1117271514495, 7802.804929876798, 8038.517688938682, 8093.919060809552, 8185.0996390398195, 8190.631421585924, 8204.958975205085, 8222.0, 7294.854102918018, 7452.664630091767, 7459.067616547932, 7611.581363025087, 7617.961910190414, 7342.9632851835395, 7391.6304184791625, 7410.333070023724, 7500.474966752275, 7512.774616761506, 7722.459427839997, 7723.420743444377, 7739.883901741366, 7789.532628042336, 7792.532448053135, 6969.965150174216, 7080.221175670569, 7100.254473280231, 7101.4673899458785, 7140.9285907140265, 7166.713331466683, 7295.124585049828, 7333.083364579427, 7361.5583065014125, 7365.705371785069], "unit": "score", "name": "mootools.html", "value": 4832.647969013831}, {"lowerIsBetter": false, "replicates": [366.10852573982356, 368.4767629965449, 372.36511747470564, 374.1338800676435, 374.7657713928793, 5888.0, 5920.792772252972, 5925.348211696715, 5934.436228558291, 5996.550258730591, 5902.881942361161, 5920.141579470974, 5921.85195370116, 5925.437083477073, 5936.4953978911735, 4457.687961842672, 4544.5682660147395, 4666.066786642668, 4670.065986802636, 4708.058388322332, 4663.2305669564485, 4665.206914824488, 4684.063187362524, 4684.718916864982, 4688.695234809727, 4644.790984405709, 4658.883527911812, 4661.067786442708, 4662.673612847102, 4664.883377915546, 4391.692581519279, 4482.484514280851, 4596.724196548218, 4627.884302892455, 4643.303504474322, 4125.834966601333, 4129.421880936671, 4129.566395528456, 4131.648809851166, 4139.606737359946, 5643.125315576092, 5650.208970744099, 5656.377798442168, 5659.688717120557, 5666.716664166775, 5388.865278368033, 5402.108652072403, 5407.188921661743, 5413.593980451482, 5413.945860541384, 6251.0, 6268.968655156695, 6269.216347956505, 6269.686515674243, 6276.87446251077, 4352.129574085196, 4473.619742321874, 4508.053308805155, 4516.954830451719, 4568.291914753186, 6519.804405867784, 6544.672766361663, 6636.13730215069, 6645.800625981228, 6653.93346066538, 4581.358609794632, 4585.0, 4586.334981427741, 4586.6789324747615, 4588.9541104588525, 4650.209464391061, 4654.650901182425, 4656.906861862743, 4657.208274593328, 4659.44086709597, 5324.334458192726, 5330.733463326818, 5331.173668081454, 5333.813316533902, 5338.065838478251, 6155.384461553809, 6193.1329613854095, 6285.59143655661, 6288.119663247149, 6341.175647165931, 1609.203444295058, 1609.2195285286627, 1613.8708903287709, 1623.3993422433775, 1630.877684173668, 1028.6708253358854, 1078.660222030058, 1085.4518468173521, 1105.7125147461718, 1107.4462768615692, 6038.305594856648, 6048.939510604926, 6055.7274922628585, 6057.666828324396, 6117.602355846856, 6463.0, 6463.9980802975615, 6469.902951455732, 6470.22357317125, 6471.644059576768, 6117.082437634391, 6118.082287656798, 6128.724207410588, 6130.141780150782, 6134.44789968896, 3451.9654803452145, 3480.6693364130365, 3484.651534846495, 3486.1458942559234, 3486.38988177068, 6598.769043083469, 6731.360520750521, 6868.141482314711, 6880.69036893341, 6886.586804791728, 6705.530612857053, 6726.22648395431, 6737.393634572814, 6739.056532085414, 6743.0, 6842.7605033824575, 6843.315668433117, 6846.486513511507, 6848.931510684929, 6866.107406037283, 6567.770128045496, 6569.146011018537, 6580.407763301135, 6580.539362244597, 6586.242582103119, 6214.223222097238, 6398.936010639834, 6418.614883107029, 6482.6434546098535, 6505.0567667688865, 6736.73053077891, 6772.729090836311, 6773.390394864486, 6777.390034896883, 6780.355866192704, 4560.429946256718, 4593.655475839392, 4597.057603191271, 4598.448186217675, 4619.676622636383, 6524.9673751630935, 6531.738730450728, 6532.608043517214, 6539.084528166156, 6541.280459149394, 6124.510039196943, 6345.206849143857, 6364.586301890362, 6380.585261958144, 6382.744690212339, 6313.08460273267, 6318.336574659595, 6352.968235158794, 6394.776182833579, 6399.520035997226, 6230.190075290365, 6230.470410015199, 6239.407256310643, 6253.874922501615, 6292.112366290003, 6423.614583125028, 6430.228372595318, 6433.517486188648, 6436.549441539048, 6443.7422503101225, 6009.158717779427, 6063.605865618721, 6169.383061693795, 6280.057991301159, 6286.559940804283], "unit": "score", "name": "prototype.html", "value": 4819.668017615279}, {"lowerIsBetter": false, "replicates": [792.9643166057526, 913.5112714697634, 922.2898368256442, 927.1331305229609, 930.8650245714367, 14419.927900360497, 15221.086734795907, 15315.234238288069, 15328.923355383222, 15377.84622153778, 13837.792433113511, 14052.437902483915, 14054.297285135728, 14058.718825623482, 14060.296985150728, 560.730849192388, 570.1163197044585, 573.4294377094776, 934.6121359635742, 961.0965692249298, 956.6603855631255, 956.9808603827919, 960.5437417226797, 961.0341606685272, 961.1109723505764, 1001.3841487485181, 1003.578497031245, 1004.437514991607, 1004.9447280399612, 1006.3307900246364, 609.850586606282, 628.9716962736665, 974.4299584742934, 992.4888682328607, 1000.0199804191897, 735.0, 735.7388127214815, 736.0284424559584, 737.4211244173351, 737.4542838299619, 14601.561953141316, 14701.632459188499, 14706.558803235814, 14707.0, 14711.11733295995, 14156.575302740832, 14218.146911185362, 14537.418503259856, 14555.636109097251, 14618.634534136625, 11742.0, 11745.29528228309, 11751.0, 11834.0, 11850.466728997217, 3870.5355357357016, 3972.7219094663387, 3982.4424580558743, 3990.102226998902, 4008.118213992917, 50000.0, 51557.48442515564, 51604.22593661061, 51725.0, 51760.0, 11327.490262938187, 11455.198136130392, 11458.255213411101, 11481.827772583418, 11515.424228788695, 20257.392278231382, 20606.793932060787, 20692.172313107607, 20717.0, 20734.170633174504, 7605.6577454014705, 8009.839803203903, 8096.7166149184495, 8360.58197090143, 8709.259712924473, 4482.193205223091, 4557.521460246693, 4635.884102897455, 4671.252599584051, 4738.0523895221095, 3256.853441595134, 3258.185453636591, 3268.428025095599, 3288.095773662262, 3293.5059741039036, 554.5175697143511, 652.1489456259532, 653.3238098568054, 654.9770758023446, 669.8291935556402, 631.119588174494, 653.4968074582545, 711.434409644334, 731.2869951796955, 770.8959290495711, 8699.652013919498, 8763.56182190888, 8836.0, 9080.22818060459, 9539.09378609031, 691.8581690753383, 698.9091418115714, 712.618748969299, 723.3598265534935, 727.4071631620318, 4261.74429534229, 4297.0, 4425.557444255549, 4463.375127482155, 4566.95433045672, 53127.468725313025, 54419.0, 55057.449425506034, 55216.44783552113, 55371.723141384035, 45191.774041130244, 46276.7686161567, 46690.0, 47115.05769884652, 47189.764051179525, 47320.5267947323, 47340.763296183984, 47683.284750728766, 48458.0, 48680.7565962175, 8973.50645714492, 9002.594883230402, 9117.361784675275, 9205.217556507772, 9221.677241296522, 35733.82133089318, 35839.0, 36128.63871361253, 36725.89822305335, 37519.24961500809, 41819.581804181566, 45368.546314536434, 46056.466894321136, 46216.537834621224, 47123.52876471191, 11761.353125578175, 11944.76110477803, 11986.880131198577, 12166.57416990401, 12412.689682758004, 12666.873331266937, 12744.6176614698, 12840.55058072963, 12930.741385172432, 13101.541446049343, 12213.450394732436, 12365.010799135867, 12672.619821405373, 12799.0, 13223.735525289632, 12403.193792403465, 12680.809787853374, 12768.170068945488, 13151.27667978232, 13256.873165781017, 12140.575079872162, 12237.694057648274, 12248.448819802952, 12288.38558072075, 12313.0, 9690.70927872165, 9873.0, 9966.651167209113, 10195.133413659922, 10267.7433064171, 9363.578638961399, 9405.95297023538, 9437.150656440954, 9508.904910950801, 9571.952140239255], "unit": "score", "name": "yui.html", "value": 6773.866562225146}], "name": "dromaeo_css", "value": 7269.489776284946}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 109.0, 106.0, 109.0, 110.0, 108.0, 98.0, 108.0, 109.0, 109.0], "unit": "score", "name": "ai-astar", "value": 107.4}, {"lowerIsBetter": true, "replicates": [163.0, 127.0, 157.0, 171.0, 128.0, 160.0, 160.0, 128.0, 176.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 149.8}, {"lowerIsBetter": true, "replicates": [159.0, 161.0, 161.0, 160.0, 162.0, 160.0, 160.0, 165.0, 160.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.0}, {"lowerIsBetter": true, "replicates": [76.0, 76.0, 74.0, 170.0, 77.0, 77.0, 74.0, 74.0, 165.0, 75.0], "unit": "score", "name": "audio-fft", "value": 93.8}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 151.0, 93.0, 93.0, 93.0, 143.0, 93.0, 93.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 108.4}, {"lowerIsBetter": true, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.1}, {"lowerIsBetter": true, "replicates": [148.0, 146.0, 146.0, 145.0, 147.0, 146.0, 145.0, 146.0, 148.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 146.2}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [54.0, 54.0, 55.0, 55.0, 54.0, 54.0, 55.0, 63.0, 52.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 54.8}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 64.0, 65.0, 64.0, 65.0, 65.0, 64.0, 64.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.6}, {"lowerIsBetter": true, "replicates": [84.0, 78.0, 79.0, 78.0, 78.0, 77.0, 76.0, 78.0, 77.0, 78.0], "unit": "score", "name": "stanford-crypto-aes", "value": 78.3}, {"lowerIsBetter": true, "replicates": [120.0, 119.0, 118.0, 114.0, 114.0, 112.0, 110.0, 120.0, 112.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 115.6}, {"lowerIsBetter": true, "replicates": [145.0, 144.0, 155.0, 145.0, 155.0, 137.0, 145.0, 142.0, 133.0, 144.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.5}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 69.0, 70.0, 67.0, 67.0, 68.0, 69.0, 70.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.8}], "name": "kraken", "value": 1504.9999999999998}]} 11:02:29 INFO - Return code: 0 11:02:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:02:29 INFO - # TBPL SUCCESS # 11:02:29 INFO - Running post-action listener: _resource_record_post_action 11:02:29 INFO - Running post-run listener: _resource_record_post_run 11:02:30 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 497565696; Read time: 8; Write time: 821200 11:02:30 INFO - install - Wall time: 15s; CPU: 16.0%; Read bytes: 0; Write bytes: 214339584; Read time: 0; Write time: 556224 11:02:30 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 245735424; Read time: 8; Write time: 250896 11:02:30 INFO - Running post-run listener: _upload_blobber_files 11:02:30 INFO - Blob upload gear active. 11:02:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:02:30 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 11:02:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:02:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:02:30 INFO - (blobuploader) - INFO - Open directory for files ... 11:02:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:02:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:02:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:02:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:02:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:02:31 INFO - (blobuploader) - INFO - Done attempting. 11:02:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:02:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:02:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:02:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:02:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:02:32 INFO - (blobuploader) - INFO - Done attempting. 11:02:32 INFO - (blobuploader) - INFO - Iteration through files over. 11:02:32 INFO - Return code: 0 11:02:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:02:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:02:32 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/02c14f752b615bce4cef33b6ebae278066ac1e0b9b816e41e0f44b906c6009c07233cbe741dbf63e96a918a8046f02f51d4b9e3f1a1d36a849a487c93a48d0e9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/528911853beea2c6e8deff102c8313cc10b3e0d5a25aa172dde506b1ac8e26ffcde4d65ec6435f4d46a58d8a9529f320e7e49b68481d99853233e2f87bf6c06f"} 11:02:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:02:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:02:32 INFO - Contents: 11:02:32 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/02c14f752b615bce4cef33b6ebae278066ac1e0b9b816e41e0f44b906c6009c07233cbe741dbf63e96a918a8046f02f51d4b9e3f1a1d36a849a487c93a48d0e9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/528911853beea2c6e8deff102c8313cc10b3e0d5a25aa172dde506b1ac8e26ffcde4d65ec6435f4d46a58d8a9529f320e7e49b68481d99853233e2f87bf6c06f"} 11:02:32 INFO - Running post-run listener: copy_logs_to_upload_dir 11:02:32 INFO - Copying logs to upload dir... 11:02:32 INFO - mkdir: /builds/slave/test/build/upload/logs 11:02:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1228.655178 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-04-14 11:02:32.139574) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 11:02:32.146973) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1460655721.354275-1231228638 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/02c14f752b615bce4cef33b6ebae278066ac1e0b9b816e41e0f44b906c6009c07233cbe741dbf63e96a918a8046f02f51d4b9e3f1a1d36a849a487c93a48d0e9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/528911853beea2c6e8deff102c8313cc10b3e0d5a25aa172dde506b1ac8e26ffcde4d65ec6435f4d46a58d8a9529f320e7e49b68481d99853233e2f87bf6c06f"} build_url:https://queue.taskcluster.net/v1/task/RwmgRKunR7qEQJ-LSeMHLg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011277 build_url: 'https://queue.taskcluster.net/v1/task/RwmgRKunR7qEQJ-LSeMHLg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/02c14f752b615bce4cef33b6ebae278066ac1e0b9b816e41e0f44b906c6009c07233cbe741dbf63e96a918a8046f02f51d4b9e3f1a1d36a849a487c93a48d0e9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/528911853beea2c6e8deff102c8313cc10b3e0d5a25aa172dde506b1ac8e26ffcde4d65ec6435f4d46a58d8a9529f320e7e49b68481d99853233e2f87bf6c06f"}' ========= master_lag: 0.42 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 11:02:32.577809) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 11:02:32.578192) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1460655721.354275-1231228638 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.003853 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 11:02:32.596658) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 11:02:32.597019) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 11:02:32.597327) ========= ========= Total master_lag: 0.53 =========