builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-020 starttime: 1450785938.11 results: success (0) buildid: 20151222024321 builduid: f6f951ce5123481a8dda69c5225bfcdf revision: 1696c9dfdd050957145c1d408f61d9c7e4f04b00 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-22 04:05:38.107121) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-22 04:05:38.107615) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-22 04:05:38.107909) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] 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=fc81d3768dcd4b6275e033c4000001b5-1450777764.221174-438808712 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006512 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-22 04:05:38.137690) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-22 04:05:38.138015) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-22 04:05:38.156892) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 04:05:38.157234) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', '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=fc81d3768dcd4b6275e033c4000001b5-1450777764.221174-438808712 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004669 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 04:05:38.207172) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-22 04:05:38.210331) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-22 04:05:38.210722) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 04:05:38.211741) ========= 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=fc81d3768dcd4b6275e033c4000001b5-1450777764.221174-438808712 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-22 04:05:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 72.9M=0s 2015-12-22 04:05:39 (72.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.204464 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 04:05:38.438856) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 04:05:38.439173) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] 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=fc81d3768dcd4b6275e033c4000001b5-1450777764.221174-438808712 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019761 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 04:05:38.491015) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-22 04:05:38.491347) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1696c9dfdd050957145c1d408f61d9c7e4f04b00 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 1696c9dfdd050957145c1d408f61d9c7e4f04b00 --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=fc81d3768dcd4b6275e033c4000001b5-1450777764.221174-438808712 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-22 04:05:40,026 truncating revision to first 12 chars 2015-12-22 04:05:40,026 Setting DEBUG logging. 2015-12-22 04:05:40,026 attempt 1/10 2015-12-22 04:05:40,026 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1696c9dfdd05?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-22 04:05:40,861 unpacking tar archive at: mozilla-central-1696c9dfdd05/testing/mozharness/ program finished with exit code 0 elapsedTime=1.109429 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-22 04:05:39.616727) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-22 04:05:39.620655) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-22 04:05:39.630894) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-22 04:05:39.631261) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-22 04:05:39.631771) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2015-12-22 04:05:39.632051) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fc81d3768dcd4b6275e033c4000001b5-1450777764.221174-438808712 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:05:41 INFO - MultiFileLogger online at 20151222 04:05:41 in /builds/slave/test 04:05:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:05:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:05:41 INFO - {'append_to_log': False, 04:05:41 INFO - 'base_work_dir': '/builds/slave/test', 04:05:41 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:05:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:05:41 INFO - 'branch': 'Firefox-Non-PGO', 04:05:41 INFO - 'buildbot_json_path': 'buildprops.json', 04:05:41 INFO - 'config_files': ('talos/linux_config.py',), 04:05:41 INFO - 'default_actions': ('clobber', 04:05:41 INFO - 'read-buildbot-config', 04:05:41 INFO - 'download-and-extract', 04:05:41 INFO - 'populate-webroot', 04:05:41 INFO - 'create-virtualenv', 04:05:41 INFO - 'install', 04:05:41 INFO - 'run-tests'), 04:05:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:05:41 INFO - 'download_minidump_stackwalk': True, 04:05:41 INFO - 'download_symbols': 'ondemand', 04:05:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:05:41 INFO - 'tooltool.py': '/tools/tooltool.py', 04:05:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:05:41 INFO - '/tools/misc-python/virtualenv.py')}, 04:05:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:05:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:05:41 INFO - 'installer_path': 'installer.exe', 04:05:41 INFO - 'log_level': 'info', 04:05:41 INFO - 'log_name': 'talos', 04:05:41 INFO - 'log_to_console': True, 04:05:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:05:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:05:41 INFO - 'opt_config_files': (), 04:05:41 INFO - 'pip_index': False, 04:05:41 INFO - 'sps_profile': False, 04:05:41 INFO - 'sps_profile_interval': 0, 04:05:41 INFO - 'suite': 'dromaeojs', 04:05:41 INFO - 'system_bits': '64', 04:05:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:05:41 INFO - 'title': 'talos-linux64-ix-020', 04:05:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:05:41 INFO - 'use_talos_json': True, 04:05:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:05:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:05:41 INFO - 'work_dir': 'build'} 04:05:41 INFO - ##### 04:05:41 INFO - ##### Running clobber step. 04:05:41 INFO - ##### 04:05:41 INFO - Running pre-action listener: _resource_record_pre_action 04:05:41 INFO - Running main action method: clobber 04:05:41 INFO - rmtree: /builds/slave/test/build 04:05:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:05:41 INFO - Running post-action listener: _resource_record_post_action 04:05:41 INFO - ##### 04:05:41 INFO - ##### Running read-buildbot-config step. 04:05:41 INFO - ##### 04:05:41 INFO - Running pre-action listener: _resource_record_pre_action 04:05:41 INFO - Running main action method: read_buildbot_config 04:05:41 INFO - Using buildbot properties: 04:05:41 INFO - { 04:05:41 INFO - "project": "", 04:05:41 INFO - "product": "firefox", 04:05:41 INFO - "script_repo_revision": "production", 04:05:41 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:05:41 INFO - "repository": "", 04:05:41 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 04:05:41 INFO - "buildid": "20151222024321", 04:05:41 INFO - "pgo_build": "False", 04:05:41 INFO - "basedir": "/builds/slave/test", 04:05:41 INFO - "buildnumber": 246, 04:05:41 INFO - "slavename": "talos-linux64-ix-020", 04:05:41 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:05:41 INFO - "platform": "ubuntu64_hw", 04:05:41 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:05:41 INFO - "branch": "mozilla-central", 04:05:41 INFO - "repo_path": "mozilla-central", 04:05:41 INFO - "revision": "1696c9dfdd050957145c1d408f61d9c7e4f04b00", 04:05:41 INFO - "stage_platform": "linux64", 04:05:41 INFO - "builduid": "f6f951ce5123481a8dda69c5225bfcdf", 04:05:41 INFO - "slavebuilddir": "test" 04:05:41 INFO - } 04:05:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/wgwDOn3iRFK19ShtaC4ZNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 04:05:41 INFO - Running post-action listener: _resource_record_post_action 04:05:41 INFO - ##### 04:05:41 INFO - ##### Running download-and-extract step. 04:05:41 INFO - ##### 04:05:41 INFO - Running pre-action listener: _resource_record_pre_action 04:05:41 INFO - Running main action method: download_and_extract 04:05:41 INFO - mkdir: /builds/slave/test/build/tests 04:05:41 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')]} 04:05:41 INFO - https://queue.taskcluster.net/v1/task/wgwDOn3iRFK19ShtaC4ZNA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:05:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wgwDOn3iRFK19ShtaC4ZNA/artifacts/public/build/test_packages.json 04:05:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wgwDOn3iRFK19ShtaC4ZNA/artifacts/public/build/test_packages.json 04:05:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wgwDOn3iRFK19ShtaC4ZNA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:05:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wgwDOn3iRFK19ShtaC4ZNA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:05:46 INFO - Downloaded 1302 bytes. 04:05:46 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:05:46 INFO - Using the following test package requirements: 04:05:46 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:05:46 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:05:46 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:05:46 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:05:46 INFO - u'jsshell-linux-x86_64.zip'], 04:05:46 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:05:46 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:05:46 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:05:46 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:05:46 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:05:46 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:05:46 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:05:46 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:05:46 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:05:46 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:05:46 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:05:46 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:05:46 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:05:46 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')]} 04:05:46 INFO - https://queue.taskcluster.net/v1/task/wgwDOn3iRFK19ShtaC4ZNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:05:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wgwDOn3iRFK19ShtaC4ZNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:05:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wgwDOn3iRFK19ShtaC4ZNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:05:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wgwDOn3iRFK19ShtaC4ZNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:05:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wgwDOn3iRFK19ShtaC4ZNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:05:48 INFO - Downloaded 21926587 bytes. 04:05:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 04:05:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:05:48 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:05:49 INFO - Return code: 0 04:05:49 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:05:49 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')]} 04:05:49 INFO - https://queue.taskcluster.net/v1/task/wgwDOn3iRFK19ShtaC4ZNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:05:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wgwDOn3iRFK19ShtaC4ZNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:05:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wgwDOn3iRFK19ShtaC4ZNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:05:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wgwDOn3iRFK19ShtaC4ZNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:05:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wgwDOn3iRFK19ShtaC4ZNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:05:54 INFO - Downloaded 21926587 bytes. 04:05:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 04:05:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:05:54 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:05:55 INFO - Return code: 0 04:05:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:55 INFO - https://queue.taskcluster.net/v1/task/wgwDOn3iRFK19ShtaC4ZNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:05:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wgwDOn3iRFK19ShtaC4ZNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:05:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wgwDOn3iRFK19ShtaC4ZNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:05:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wgwDOn3iRFK19ShtaC4ZNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:05:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wgwDOn3iRFK19ShtaC4ZNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:05:56 INFO - Downloaded 11132277 bytes. 04:05:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 04:05:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:05:56 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 04:05:57 INFO - Return code: 0 04:05:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:57 INFO - https://queue.taskcluster.net/v1/task/wgwDOn3iRFK19ShtaC4ZNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:05:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wgwDOn3iRFK19ShtaC4ZNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:05:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wgwDOn3iRFK19ShtaC4ZNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:05:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wgwDOn3iRFK19ShtaC4ZNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:05:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wgwDOn3iRFK19ShtaC4ZNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:05:58 INFO - Downloaded 53348232 bytes. 04:05:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/wgwDOn3iRFK19ShtaC4ZNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:05:58 INFO - mkdir: /builds/slave/test/properties 04:05:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:05:58 INFO - Writing to file /builds/slave/test/properties/build_url 04:05:58 INFO - Contents: 04:05:58 INFO - build_url:https://queue.taskcluster.net/v1/task/wgwDOn3iRFK19ShtaC4ZNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:05:58 INFO - Running post-action listener: _resource_record_post_action 04:05:58 INFO - Running post-action listener: set_extra_try_arguments 04:05:58 INFO - ##### 04:05:58 INFO - ##### Running populate-webroot step. 04:05:58 INFO - ##### 04:05:58 INFO - Running pre-action listener: _resource_record_pre_action 04:05:58 INFO - Running main action method: populate_webroot 04:05:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:05:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:05:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:05:58 INFO - '--tppagecycles', 04:05:58 INFO - '7'], 04:05:58 INFO - 'tests': ['tsvgm']}}, 04:05:58 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:05:58 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:05:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:05:58 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:05:58 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:05:58 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:05:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:05:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:58 INFO - 'talos_options': ['--e10s'], 04:05:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:05:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:58 INFO - 'tests': ['damp', 'tps']}, 04:05:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:58 INFO - 'talos_options': ['--e10s'], 04:05:58 INFO - 'tests': ['damp', 'tps']}, 04:05:58 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:05:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:05:58 INFO - 'other': {'tests': ['a11yr', 04:05:58 INFO - 'ts_paint', 04:05:58 INFO - 'tpaint', 04:05:58 INFO - 'sessionrestore', 04:05:58 INFO - 'sessionrestore_no_auto_restore']}, 04:05:58 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:05:58 INFO - 'tests': ['a11yr', 04:05:58 INFO - 'ts_paint', 04:05:58 INFO - 'tpaint', 04:05:58 INFO - 'sessionrestore', 04:05:58 INFO - 'sessionrestore_no_auto_restore']}, 04:05:58 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:05:58 INFO - 'tests': ['a11yr', 04:05:58 INFO - 'ts_paint', 04:05:58 INFO - 'tpaint', 04:05:58 INFO - 'sessionrestore', 04:05:58 INFO - 'sessionrestore_no_auto_restore']}, 04:05:58 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:05:58 INFO - 'tests': ['a11yr', 04:05:58 INFO - 'ts_paint', 04:05:58 INFO - 'tpaint', 04:05:58 INFO - 'sessionrestore', 04:05:58 INFO - 'sessionrestore_no_auto_restore']}, 04:05:58 INFO - 'other_l64': {'tests': ['a11yr', 04:05:58 INFO - 'ts_paint', 04:05:58 INFO - 'tpaint', 04:05:58 INFO - 'sessionrestore', 04:05:58 INFO - 'sessionrestore_no_auto_restore']}, 04:05:58 INFO - 'other_nol64': {'tests': ['a11yr', 04:05:58 INFO - 'ts_paint', 04:05:58 INFO - 'tpaint', 04:05:58 INFO - 'sessionrestore', 04:05:58 INFO - 'sessionrestore_no_auto_restore']}, 04:05:58 INFO - 'svgr': {'tests': ['tsvgx', 04:05:58 INFO - 'tsvgr_opacity', 04:05:58 INFO - 'tart', 04:05:58 INFO - 'tscrollx', 04:05:58 INFO - 'cart']}, 04:05:58 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:05:58 INFO - 'tests': ['tsvgx', 04:05:58 INFO - 'tsvgr_opacity', 04:05:58 INFO - 'tart', 04:05:58 INFO - 'tscrollx', 04:05:58 INFO - 'cart']}, 04:05:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:58 INFO - 'tests': ['tp5o']}, 04:05:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:58 INFO - 'talos_options': ['--e10s'], 04:05:58 INFO - 'tests': ['tp5o']}, 04:05:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:58 INFO - 'talos_options': ['--xperf_path', 04:05:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:05:58 INFO - 'tests': ['tp5n']}, 04:05:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:58 INFO - 'talos_options': ['--e10s', 04:05:58 INFO - '--xperf_path', 04:05:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:05:58 INFO - 'tests': ['tp5n']}}, 04:05:58 INFO - 'talos.zip': {'path': '', 04:05:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:05:58 INFO - Running post-action listener: _resource_record_post_action 04:05:58 INFO - ##### 04:05:58 INFO - ##### Running create-virtualenv step. 04:05:58 INFO - ##### 04:05:58 INFO - Running pre-action listener: _resource_record_pre_action 04:05:58 INFO - Running main action method: create_virtualenv 04:05:58 INFO - Creating virtualenv /builds/slave/test/build/venv 04:05:58 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 04:05:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:05:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:05:58 INFO - Using real prefix '/usr' 04:05:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:05:59 INFO - Installing distribute.............................................................................................................................................................................................done. 04:06:01 INFO - Installing pip.................done. 04:06:01 INFO - Return code: 0 04:06:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:06:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fae8b126f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2174dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22073d0>, '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 0x2172ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2173360>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1450777764.221174-438808712', '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 04:06:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 04:06:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 04:06:01 INFO - Using env: {'DISPLAY': ':0', 04:06:01 INFO - 'HOME': '/home/cltbld', 04:06:01 INFO - 'LANG': 'en_US.UTF-8', 04:06:01 INFO - 'LANGUAGE': 'en_US:en', 04:06:01 INFO - 'LOGNAME': 'cltbld', 04:06:01 INFO - 'MAIL': '/var/mail/cltbld', 04:06:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:01 INFO - 'MOZ_NO_REMOTE': '1', 04:06:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:01 INFO - 'NO_EM_RESTART': '1', 04:06:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:01 INFO - 'PWD': '/builds/slave/test', 04:06:01 INFO - 'SHELL': '/bin/bash', 04:06:01 INFO - 'SHLVL': '1', 04:06:01 INFO - 'TERM': 'linux', 04:06:01 INFO - 'TMOUT': '86400', 04:06:01 INFO - 'USER': 'cltbld', 04:06:01 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1450777764.221174-438808712', 04:06:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:01 INFO - '_': '/tools/buildbot/bin/python'} 04:06:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:01 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 04:06:01 INFO - Cleaning up... 04:06:01 INFO - Return code: 0 04:06:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:06:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fae8b126f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2174dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22073d0>, '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 0x2172ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2173360>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1450777764.221174-438808712', '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 04:06:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 04:06:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 04:06:01 INFO - Using env: {'DISPLAY': ':0', 04:06:01 INFO - 'HOME': '/home/cltbld', 04:06:01 INFO - 'LANG': 'en_US.UTF-8', 04:06:01 INFO - 'LANGUAGE': 'en_US:en', 04:06:01 INFO - 'LOGNAME': 'cltbld', 04:06:01 INFO - 'MAIL': '/var/mail/cltbld', 04:06:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:01 INFO - 'MOZ_NO_REMOTE': '1', 04:06:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:01 INFO - 'NO_EM_RESTART': '1', 04:06:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:01 INFO - 'PWD': '/builds/slave/test', 04:06:01 INFO - 'SHELL': '/bin/bash', 04:06:01 INFO - 'SHLVL': '1', 04:06:01 INFO - 'TERM': 'linux', 04:06:01 INFO - 'TMOUT': '86400', 04:06:01 INFO - 'USER': 'cltbld', 04:06:01 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1450777764.221174-438808712', 04:06:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:01 INFO - '_': '/tools/buildbot/bin/python'} 04:06:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:01 INFO - Downloading/unpacking psutil>=0.7.1 04:06:01 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 04:06:01 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 04:06:01 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 04:06:01 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 04:06:01 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 04:06:01 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 04:06:03 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 04:06:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:06:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:06:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:06:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:06:03 INFO - Installing collected packages: psutil 04:06:03 INFO - Running setup.py install for psutil 04:06:03 INFO - building 'psutil._psutil_linux' extension 04:06:03 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 04:06:03 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 04:06:03 INFO - building 'psutil._psutil_posix' extension 04:06:03 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 04:06:03 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 04:06:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:06:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:06:03 INFO - Successfully installed psutil 04:06:03 INFO - Cleaning up... 04:06:03 INFO - Return code: 0 04:06:03 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:06:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fae8b126f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2174dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22073d0>, '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 0x2172ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2173360>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1450777764.221174-438808712', '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 04:06:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 04:06:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 04:06:03 INFO - Using env: {'DISPLAY': ':0', 04:06:03 INFO - 'HOME': '/home/cltbld', 04:06:03 INFO - 'LANG': 'en_US.UTF-8', 04:06:03 INFO - 'LANGUAGE': 'en_US:en', 04:06:03 INFO - 'LOGNAME': 'cltbld', 04:06:03 INFO - 'MAIL': '/var/mail/cltbld', 04:06:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:03 INFO - 'MOZ_NO_REMOTE': '1', 04:06:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:03 INFO - 'NO_EM_RESTART': '1', 04:06:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:03 INFO - 'PWD': '/builds/slave/test', 04:06:03 INFO - 'SHELL': '/bin/bash', 04:06:03 INFO - 'SHLVL': '1', 04:06:03 INFO - 'TERM': 'linux', 04:06:03 INFO - 'TMOUT': '86400', 04:06:03 INFO - 'USER': 'cltbld', 04:06:03 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1450777764.221174-438808712', 04:06:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:03 INFO - '_': '/tools/buildbot/bin/python'} 04:06:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:06:04 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 04:06:04 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 04:06:04 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 04:06:04 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 04:06:04 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 04:06:04 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 04:06:05 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:06:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:06:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:06:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:06:05 INFO - Installing collected packages: mozsystemmonitor 04:06:05 INFO - Running setup.py install for mozsystemmonitor 04:06:05 INFO - Successfully installed mozsystemmonitor 04:06:05 INFO - Cleaning up... 04:06:06 INFO - Return code: 0 04:06:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:06:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fae8b126f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2174dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22073d0>, '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 0x2172ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2173360>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1450777764.221174-438808712', '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 04:06:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 04:06:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 04:06:06 INFO - Using env: {'DISPLAY': ':0', 04:06:06 INFO - 'HOME': '/home/cltbld', 04:06:06 INFO - 'LANG': 'en_US.UTF-8', 04:06:06 INFO - 'LANGUAGE': 'en_US:en', 04:06:06 INFO - 'LOGNAME': 'cltbld', 04:06:06 INFO - 'MAIL': '/var/mail/cltbld', 04:06:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:06 INFO - 'MOZ_NO_REMOTE': '1', 04:06:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:06 INFO - 'NO_EM_RESTART': '1', 04:06:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:06 INFO - 'PWD': '/builds/slave/test', 04:06:06 INFO - 'SHELL': '/bin/bash', 04:06:06 INFO - 'SHLVL': '1', 04:06:06 INFO - 'TERM': 'linux', 04:06:06 INFO - 'TMOUT': '86400', 04:06:06 INFO - 'USER': 'cltbld', 04:06:06 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1450777764.221174-438808712', 04:06:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:06 INFO - '_': '/tools/buildbot/bin/python'} 04:06:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:06 INFO - Downloading/unpacking blobuploader==1.2.4 04:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:08 INFO - Downloading blobuploader-1.2.4.tar.gz 04:06:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:06:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:06:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:06:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:06:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:06:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:06:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:08 INFO - Downloading docopt-0.6.1.tar.gz 04:06:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:06:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:06:09 INFO - Installing collected packages: blobuploader, requests, docopt 04:06:09 INFO - Running setup.py install for blobuploader 04:06:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:06:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:06:09 INFO - Running setup.py install for requests 04:06:09 INFO - Running setup.py install for docopt 04:06:09 INFO - Successfully installed blobuploader requests docopt 04:06:09 INFO - Cleaning up... 04:06:09 INFO - Return code: 0 04:06:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:06:09 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')]} 04:06:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:09 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')]} 04:06:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fae8b126f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2174dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22073d0>, '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 0x2172ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2173360>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1450777764.221174-438808712', '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 04:06:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 04:06:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --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 04:06:09 INFO - Using env: {'DISPLAY': ':0', 04:06:09 INFO - 'HOME': '/home/cltbld', 04:06:09 INFO - 'LANG': 'en_US.UTF-8', 04:06:09 INFO - 'LANGUAGE': 'en_US:en', 04:06:09 INFO - 'LOGNAME': 'cltbld', 04:06:09 INFO - 'MAIL': '/var/mail/cltbld', 04:06:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:09 INFO - 'MOZ_NO_REMOTE': '1', 04:06:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:09 INFO - 'NO_EM_RESTART': '1', 04:06:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:09 INFO - 'PWD': '/builds/slave/test', 04:06:09 INFO - 'SHELL': '/bin/bash', 04:06:09 INFO - 'SHLVL': '1', 04:06:09 INFO - 'TERM': 'linux', 04:06:09 INFO - 'TMOUT': '86400', 04:06:09 INFO - 'USER': 'cltbld', 04:06:09 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1450777764.221174-438808712', 04:06:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:09 INFO - '_': '/tools/buildbot/bin/python'} 04:06:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:06:09 INFO - Running setup.py (path:/tmp/pip-YBdR0v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:06:09 INFO - Running setup.py (path:/tmp/pip-Alpob3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:06:10 INFO - Running setup.py (path:/tmp/pip-Ut5ynP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:06:10 INFO - Running setup.py (path:/tmp/pip-VUMmDL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:06:10 INFO - Running setup.py (path:/tmp/pip-X27P_w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:06:10 INFO - Running setup.py (path:/tmp/pip-ld4MkO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:06:10 INFO - Running setup.py (path:/tmp/pip-zgIPUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:06:10 INFO - Running setup.py (path:/tmp/pip-eFlfqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:06:10 INFO - Running setup.py (path:/tmp/pip-RXRBOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:06:10 INFO - Running setup.py (path:/tmp/pip-NBq_cH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:06:10 INFO - Running setup.py (path:/tmp/pip-lB3hLB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:06:10 INFO - Running setup.py (path:/tmp/pip-aaCGrT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:06:10 INFO - Running setup.py (path:/tmp/pip-us488K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:06:10 INFO - Running setup.py (path:/tmp/pip-ZpfrGQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:06:10 INFO - Running setup.py (path:/tmp/pip-LKIARk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:06:10 INFO - Running setup.py (path:/tmp/pip-hWbtZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:06:11 INFO - Running setup.py (path:/tmp/pip-yC1Jcx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:06:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:06:11 INFO - Running setup.py install for manifestparser 04:06:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:06:11 INFO - Running setup.py install for mozcrash 04:06:11 INFO - Running setup.py install for mozdebug 04:06:11 INFO - Running setup.py install for mozdevice 04:06:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:06:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:06:11 INFO - Running setup.py install for mozfile 04:06:11 INFO - Running setup.py install for mozhttpd 04:06:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:06:11 INFO - Running setup.py install for mozinfo 04:06:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:06:11 INFO - Running setup.py install for mozInstall 04:06:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:06:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:06:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:06:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:06:11 INFO - Running setup.py install for mozleak 04:06:11 INFO - Running setup.py install for mozlog 04:06:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:06:12 INFO - Running setup.py install for moznetwork 04:06:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:06:12 INFO - Running setup.py install for mozprocess 04:06:12 INFO - Running setup.py install for mozprofile 04:06:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:06:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:06:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:06:12 INFO - Running setup.py install for mozrunner 04:06:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:06:12 INFO - Running setup.py install for mozscreenshot 04:06:12 INFO - Running setup.py install for moztest 04:06:12 INFO - Running setup.py install for mozversion 04:06:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:06:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:06:12 INFO - Cleaning up... 04:06:12 INFO - Return code: 0 04:06:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:06:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fae8b126f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2174dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22073d0>, '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 0x2172ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2173360>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1450777764.221174-438808712', '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 04:06:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 04:06:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 04:06:12 INFO - Using env: {'DISPLAY': ':0', 04:06:12 INFO - 'HOME': '/home/cltbld', 04:06:12 INFO - 'LANG': 'en_US.UTF-8', 04:06:12 INFO - 'LANGUAGE': 'en_US:en', 04:06:12 INFO - 'LOGNAME': 'cltbld', 04:06:12 INFO - 'MAIL': '/var/mail/cltbld', 04:06:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:12 INFO - 'MOZ_NO_REMOTE': '1', 04:06:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:12 INFO - 'NO_EM_RESTART': '1', 04:06:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:12 INFO - 'PWD': '/builds/slave/test', 04:06:12 INFO - 'SHELL': '/bin/bash', 04:06:12 INFO - 'SHLVL': '1', 04:06:12 INFO - 'TERM': 'linux', 04:06:12 INFO - 'TMOUT': '86400', 04:06:12 INFO - 'USER': 'cltbld', 04:06:12 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1450777764.221174-438808712', 04:06:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:12 INFO - '_': '/tools/buildbot/bin/python'} 04:06:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:06:13 INFO - Running setup.py (path:/tmp/pip-0Vcr5t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:06:13 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)) 04:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:06:13 INFO - Running setup.py (path:/tmp/pip-k8JuRx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:06:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 04:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:06:13 INFO - Running setup.py (path:/tmp/pip-Ksrhkd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:06:13 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)) 04:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:06:13 INFO - Running setup.py (path:/tmp/pip-uD3t15-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:06:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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)) 04:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:06:13 INFO - Running setup.py (path:/tmp/pip-AUgAsM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:06:13 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)) 04:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:06:13 INFO - Running setup.py (path:/tmp/pip-5mGSdu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:06:13 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)) 04:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:06:13 INFO - Running setup.py (path:/tmp/pip-h6kdTL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:06:13 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)) 04:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:06:13 INFO - Running setup.py (path:/tmp/pip-W0mH4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:06:13 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)) 04:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:06:13 INFO - Running setup.py (path:/tmp/pip-S_Qjub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:06:13 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)) 04:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:06:13 INFO - Running setup.py (path:/tmp/pip-c9sci6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:06:13 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)) 04:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:06:13 INFO - Running setup.py (path:/tmp/pip-Wsexq9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:06:13 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)) 04:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:06:13 INFO - Running setup.py (path:/tmp/pip-izs_ye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:06:13 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)) 04:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:06:13 INFO - Running setup.py (path:/tmp/pip-NwHSfk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:06:14 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)) 04:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:06:14 INFO - Running setup.py (path:/tmp/pip-H5WtXL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:06:14 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)) 04:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:06:14 INFO - Running setup.py (path:/tmp/pip-qrjoMO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:06:14 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)) 04:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:06:14 INFO - Running setup.py (path:/tmp/pip-jS7wLW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:06:14 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)) 04:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:06:14 INFO - Running setup.py (path:/tmp/pip-I1Jm75-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:06:14 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)) 04:06:14 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:06:14 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:06:14 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)) 04:06:14 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:06:14 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:06:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:06:14 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 04:06:14 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 04:06:14 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 04:06:14 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 04:06:14 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 04:06:14 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 04:06:15 INFO - Downloading blessings-1.5.1.tar.gz 04:06:15 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 04:06:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:06:16 INFO - Installing collected packages: blessings 04:06:16 INFO - Running setup.py install for blessings 04:06:16 INFO - Successfully installed blessings 04:06:16 INFO - Cleaning up... 04:06:16 INFO - Return code: 0 04:06:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:06:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:06:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:06:16 INFO - Reading from file tmpfile_stdout 04:06:16 INFO - Current package versions: 04:06:16 INFO - argparse == 1.2.1 04:06:16 INFO - blessings == 1.5.1 04:06:16 INFO - blobuploader == 1.2.4 04:06:16 INFO - docopt == 0.6.1 04:06:16 INFO - manifestparser == 1.1 04:06:16 INFO - mozInstall == 1.12 04:06:16 INFO - mozcrash == 0.16 04:06:16 INFO - mozdebug == 0.1 04:06:16 INFO - mozdevice == 0.47 04:06:16 INFO - mozfile == 1.2 04:06:16 INFO - mozhttpd == 0.7 04:06:16 INFO - mozinfo == 0.9 04:06:16 INFO - mozleak == 0.1 04:06:16 INFO - mozlog == 3.1 04:06:16 INFO - moznetwork == 0.27 04:06:16 INFO - mozprocess == 0.22 04:06:16 INFO - mozprofile == 0.28 04:06:16 INFO - mozrunner == 6.11 04:06:16 INFO - mozscreenshot == 0.1 04:06:16 INFO - mozsystemmonitor == 0.0 04:06:16 INFO - moztest == 0.7 04:06:16 INFO - mozversion == 1.4 04:06:16 INFO - psutil == 3.1.1 04:06:16 INFO - requests == 1.2.3 04:06:16 INFO - wsgiref == 0.1.2 04:06:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:06:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fae8b126f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2174dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22073d0>, '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 0x2172ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2173360>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1450777764.221174-438808712', '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 04:06:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 04:06:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 04:06:16 INFO - Using env: {'DISPLAY': ':0', 04:06:16 INFO - 'HOME': '/home/cltbld', 04:06:16 INFO - 'LANG': 'en_US.UTF-8', 04:06:16 INFO - 'LANGUAGE': 'en_US:en', 04:06:16 INFO - 'LOGNAME': 'cltbld', 04:06:16 INFO - 'MAIL': '/var/mail/cltbld', 04:06:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:16 INFO - 'MOZ_NO_REMOTE': '1', 04:06:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:16 INFO - 'NO_EM_RESTART': '1', 04:06:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:16 INFO - 'PWD': '/builds/slave/test', 04:06:16 INFO - 'SHELL': '/bin/bash', 04:06:16 INFO - 'SHLVL': '1', 04:06:16 INFO - 'TERM': 'linux', 04:06:16 INFO - 'TMOUT': '86400', 04:06:16 INFO - 'USER': 'cltbld', 04:06:16 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1450777764.221174-438808712', 04:06:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:16 INFO - '_': '/tools/buildbot/bin/python'} 04:06:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:16 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)) 04:06:16 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)) 04:06:16 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)) 04:06:16 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)) 04:06:16 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)) 04:06:16 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)) 04:06:16 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)) 04:06:16 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)) 04:06:16 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)) 04:06:16 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)) 04:06:16 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)) 04:06:16 INFO - Cleaning up... 04:06:16 INFO - Return code: 0 04:06:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:06:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fae8b126f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2174dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22073d0>, '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 0x2172ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2173360>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1450777764.221174-438808712', '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 04:06:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 04:06:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 04:06:16 INFO - Using env: {'DISPLAY': ':0', 04:06:16 INFO - 'HOME': '/home/cltbld', 04:06:16 INFO - 'LANG': 'en_US.UTF-8', 04:06:16 INFO - 'LANGUAGE': 'en_US:en', 04:06:16 INFO - 'LOGNAME': 'cltbld', 04:06:16 INFO - 'MAIL': '/var/mail/cltbld', 04:06:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:16 INFO - 'MOZ_NO_REMOTE': '1', 04:06:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:16 INFO - 'NO_EM_RESTART': '1', 04:06:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:16 INFO - 'PWD': '/builds/slave/test', 04:06:16 INFO - 'SHELL': '/bin/bash', 04:06:16 INFO - 'SHLVL': '1', 04:06:16 INFO - 'TERM': 'linux', 04:06:16 INFO - 'TMOUT': '86400', 04:06:16 INFO - 'USER': 'cltbld', 04:06:16 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1450777764.221174-438808712', 04:06:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:16 INFO - '_': '/tools/buildbot/bin/python'} 04:06:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:16 INFO - Downloading/unpacking jsonschema 04:06:16 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 04:06:16 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 04:06:16 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 04:06:16 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 04:06:16 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 04:06:16 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 04:06:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:06:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 04:06:18 INFO - Downloading/unpacking functools32 (from jsonschema) 04:06: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 04:06: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 04:06: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 04:06: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 04:06: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 04:06: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 04:06:18 INFO - Downloading functools32-3.2.3-2.tar.gz 04:06:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 04:06:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:06:18 INFO - warning: no files found matching '*.txt' 04:06:18 INFO - no previously-included directories found matching 'build' 04:06:18 INFO - no previously-included directories found matching 'dist' 04:06:18 INFO - no previously-included directories found matching '.git*' 04:06:18 INFO - Installing collected packages: jsonschema, functools32 04:06:18 INFO - Running setup.py install for functools32 04:06:18 INFO - warning: no files found matching '*.txt' 04:06:18 INFO - no previously-included directories found matching 'build' 04:06:18 INFO - no previously-included directories found matching 'dist' 04:06:18 INFO - no previously-included directories found matching '.git*' 04:06:18 INFO - Successfully installed jsonschema functools32 04:06:18 INFO - Cleaning up... 04:06:19 INFO - Return code: 0 04:06:19 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:06:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fae8b126f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2174dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22073d0>, '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 0x2172ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2173360>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1450777764.221174-438808712', '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 04:06:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 04:06:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 04:06:19 INFO - Using env: {'DISPLAY': ':0', 04:06:19 INFO - 'HOME': '/home/cltbld', 04:06:19 INFO - 'LANG': 'en_US.UTF-8', 04:06:19 INFO - 'LANGUAGE': 'en_US:en', 04:06:19 INFO - 'LOGNAME': 'cltbld', 04:06:19 INFO - 'MAIL': '/var/mail/cltbld', 04:06:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:19 INFO - 'MOZ_NO_REMOTE': '1', 04:06:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:19 INFO - 'NO_EM_RESTART': '1', 04:06:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:19 INFO - 'PWD': '/builds/slave/test', 04:06:19 INFO - 'SHELL': '/bin/bash', 04:06:19 INFO - 'SHLVL': '1', 04:06:19 INFO - 'TERM': 'linux', 04:06:19 INFO - 'TMOUT': '86400', 04:06:19 INFO - 'USER': 'cltbld', 04:06:19 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1450777764.221174-438808712', 04:06:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:19 INFO - '_': '/tools/buildbot/bin/python'} 04:06:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:19 INFO - Downloading/unpacking flake8 04:06:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:06:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 04:06:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:06:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:06:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 04:06:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:06: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 04:06: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 04:06: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 04:06: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 04:06: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 04:06: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 04:06:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 04:06:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:06: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 04:06: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 04:06: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 04:06: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 04:06: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 04:06: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 04:06:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:06:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:06:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:06:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:06:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:06:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:06:21 INFO - no previously-included directories found matching 'docs/_build' 04:06:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:06:21 INFO - Running setup.py install for pep8 04:06:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:06:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:06:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:06:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:06:21 INFO - no previously-included directories found matching 'docs/_build' 04:06:21 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:06:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:06:21 INFO - Cleaning up... 04:06:21 INFO - Return code: 0 04:06:21 INFO - Running post-action listener: _resource_record_post_action 04:06:21 INFO - Running post-action listener: _start_resource_monitoring 04:06:21 INFO - Starting resource monitoring. 04:06:21 INFO - ##### 04:06:21 INFO - ##### Running install step. 04:06:21 INFO - ##### 04:06:21 INFO - Running pre-action listener: _resource_record_pre_action 04:06:21 INFO - Running main action method: install 04:06:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:06:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:06:21 INFO - Reading from file tmpfile_stdout 04:06:21 INFO - Detecting whether we're running mozinstall >=1.0... 04:06:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:06:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:06:22 INFO - Reading from file tmpfile_stdout 04:06:22 INFO - Output received: 04:06:22 INFO - Usage: mozinstall [options] installer 04:06:22 INFO - Options: 04:06:22 INFO - -h, --help show this help message and exit 04:06:22 INFO - -d DEST, --destination=DEST 04:06:22 INFO - Directory to install application into. [default: 04:06:22 INFO - "/builds/slave/test"] 04:06:22 INFO - --app=APP Application being installed. [default: firefox] 04:06:22 INFO - mkdir: /builds/slave/test/build/application 04:06:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:06:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:06:37 INFO - Reading from file tmpfile_stdout 04:06:37 INFO - Output received: 04:06:37 INFO - /builds/slave/test/build/application/firefox/firefox 04:06:37 INFO - Running post-action listener: _resource_record_post_action 04:06:37 INFO - ##### 04:06:37 INFO - ##### Running run-tests step. 04:06:37 INFO - ##### 04:06:37 INFO - Running pre-action listener: _resource_record_pre_action 04:06:37 INFO - Running main action method: run_tests 04:06:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:06:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:06:37 INFO - Python 2.7.3 04:06:37 INFO - Return code: 0 04:06:37 INFO - grabbing minidump binary from tooltool 04:06:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:37 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 0x22073d0>, '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 0x2172ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2173360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:06:37 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 04:06:37 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 04:06:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:06:37 INFO - Return code: 0 04:06:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:06:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:06:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:06:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:06:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:06:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:06:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:06:38 INFO - Return code: 0 04:06:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/wgwDOn3iRFK19ShtaC4ZNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 04:06:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/wgwDOn3iRFK19ShtaC4ZNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --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 04:06:38 INFO - Using env: {'DISPLAY': ':0', 04:06:38 INFO - 'HOME': '/home/cltbld', 04:06:38 INFO - 'LANG': 'en_US.UTF-8', 04:06:38 INFO - 'LANGUAGE': 'en_US:en', 04:06:38 INFO - 'LOGNAME': 'cltbld', 04:06:38 INFO - 'MAIL': '/var/mail/cltbld', 04:06:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:06:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:06:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:38 INFO - 'MOZ_NO_REMOTE': '1', 04:06:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:06:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:38 INFO - 'NO_EM_RESTART': '1', 04:06:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:38 INFO - 'PWD': '/builds/slave/test', 04:06:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:06:38 INFO - 'SHELL': '/bin/bash', 04:06:38 INFO - 'SHLVL': '1', 04:06:38 INFO - 'TERM': 'linux', 04:06:38 INFO - 'TMOUT': '86400', 04:06:38 INFO - 'USER': 'cltbld', 04:06:38 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1450777764.221174-438808712', 04:06:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:38 INFO - '_': '/tools/buildbot/bin/python'} 04:06:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/wgwDOn3iRFK19ShtaC4ZNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 04:06:38 INFO - mozversion application_buildid: 20151222024321 04:06:38 INFO - mozversion application_changeset: 1696c9dfdd050957145c1d408f61d9c7e4f04b00 04:06:38 INFO - mozversion application_display_name: Nightly 04:06:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:06:38 INFO - mozversion application_name: Firefox 04:06:38 INFO - mozversion application_remotingname: firefox 04:06:38 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:06:38 INFO - mozversion application_vendor: Mozilla 04:06:38 INFO - mozversion application_version: 46.0a1 04:06:38 INFO - mozversion platform_buildid: 20151222024321 04:06:38 INFO - mozversion platform_changeset: 1696c9dfdd050957145c1d408f61d9c7e4f04b00 04:06:38 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:06:38 INFO - mozversion platform_version: 46.0a1 04:06:38 INFO - using testdate: 1450785998 04:06:38 INFO - actual date: 1450785998 04:06:38 INFO - starting webserver on 'localhost:37352' 04:06:38 INFO - SUITE-START | Running 3 tests 04:06:38 INFO - TEST-START | dromaeo_css 04:06:38 INFO - operating with platform_type : linux_ 04:06:38 INFO - Initialising browser for dromaeo_css test... 04:06:38 INFO - TEST-INFO | started process 12093 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKrtMXx/profile http://localhost:37352/getInfo.html) 04:06:43 INFO - PROCESS | 12093 | JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 04:06:43 INFO - PROCESS | 12093 | __metrics Screen width/height:1600/1200 04:06:43 INFO - PROCESS | 12093 | colorDepth:24 04:06:43 INFO - PROCESS | 12093 | Browser inner width/height: 1024/697 04:06:43 INFO - PROCESS | 12093 | __metrics 04:06:43 INFO - PROCESS | 12093 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:06:43 INFO - PROCESS | 12093 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:06:44 INFO - TEST-INFO | 12093: exit 0 04:06:44 INFO - Browser initialized. 04:06:44 INFO - Running cycle 1/1 for dromaeo_css test... 04:06:44 INFO - TEST-INFO | started process 12186 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKrtMXx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:06:56 INFO - PROCESS | 12186 | RSS: Main: 149684224 04:06:56 INFO - PROCESS | 12186 | 04:07:48 INFO - PROCESS | 12186 | 1450786068412 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] 04:10:00 INFO - PROCESS | 12186 | Cycle 1(1): loaded http://localhost:37352/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37352/tests/dromaeo/cssquery-ext.html) 04:10:01 INFO - PROCESS | 12186 | RSS: Main: 259072000 04:10:01 INFO - PROCESS | 12186 | 04:13:03 INFO - PROCESS | 12186 | Cycle 1(1): loaded http://localhost:37352/tests/dromaeo/cssquery-ext.html (next: http://localhost:37352/tests/dromaeo/cssquery-jquery.html) 04:13:04 INFO - PROCESS | 12186 | RSS: Main: 229163008 04:13:04 INFO - PROCESS | 12186 | 04:16:06 INFO - PROCESS | 12186 | Cycle 1(1): loaded http://localhost:37352/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37352/tests/dromaeo/cssquery-mootools.html) 04:16:07 INFO - PROCESS | 12186 | RSS: Main: 234594304 04:16:07 INFO - PROCESS | 12186 | 04:19:09 INFO - PROCESS | 12186 | Cycle 1(1): loaded http://localhost:37352/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37352/tests/dromaeo/cssquery-prototype.html) 04:19:09 INFO - PROCESS | 12186 | RSS: Main: 213684224 04:19:09 INFO - PROCESS | 12186 | 04:22:12 INFO - PROCESS | 12186 | Cycle 1(1): loaded http://localhost:37352/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37352/tests/dromaeo/cssquery-yui.html) 04:22:12 INFO - PROCESS | 12186 | RSS: Main: 218976256 04:22:12 INFO - PROCESS | 12186 | 04:25:15 INFO - PROCESS | 12186 | Cycle 1(1): loaded http://localhost:37352/tests/dromaeo/cssquery-yui.html (next: http://localhost:37352/tests/dromaeo/cssquery-dojo.html) 04:25:15 INFO - PROCESS | 12186 | RSS: Main: 270057472 04:25:15 INFO - PROCESS | 12186 | 04:25:15 INFO - PROCESS | 12186 | __start_tp_report 04:25:15 INFO - PROCESS | 12186 | _x_x_mozilla_page_load 04:25:15 INFO - PROCESS | 12186 | _x_x_mozilla_page_load_details 04:25:15 INFO - PROCESS | 12186 | |i|pagename|runs| 04:25:15 INFO - PROCESS | 12186 | |0;dojo.html;2578.12343803107;2656.5882288245302;2663.214351766229;2679.517686816372;2681.8524981126043;4417.1607394595;4521.773911304438;4544.431946006749;4581.656375771818;4590.609798167152;4553.203189441851;4595.7242565446095;4618.745968971705;4632.49042605314;4652.930206046904;4100;4138.193052354792;4300.741955482681;4361.236783562864;4373.387725718402;4108.979455102721;4198.538160802294;4310.374995625632;4332.566743325674;4369.847055353063;4135.545090040093;4172.561881002512;4202;4224.049588842517;4248.192843359782;4238.512571054337;4263.189993901149;4265.552117027699;4305.956940430587;4312.202242585132;4101.036256479725;4219.641330486882;4260.126674031816;4260.510041345254;4313.892152696177;4387.188370151533;4491.708038977456;4499.797509112098;4519.050999290153;4539.387182730322;4915.066137433876;4920.926186107211;4923.113839508887;4923.48303428142;4976.950230497721;4698.483166851644;4945.505449455061;4945.703257804544;4958.206686930074;4994.051130285234;4484.506704262529;4486.730796152241;4502.887427814266;4586.128635559233;4644.744539050384;5031.874203144877;5048.091343558195;5048.72232027242;5051.6716413433005;5101.846944591668;4696.084263568571;4842;4847.854564363075;4848;4890.584300334512;4805.495422980606;4855.927161092586;4858.05267972749;4861.052094841542;4917.950820491821;4866.245731911488;4870.853874383774;4872.853814385574;4875.926861097087;4911.926321105187;4686.27362758773;4841.491643377465;4845.345878306454;4849.612031037508;4898.338724272177;3991.7604943703473;4036.4752582164133;4052.230076285496;4052.2908491014546;4076.5108187017154;3589.4615807629066;3607.549056367954;3615.132368231658;3647.963520364762;3661.3775658137647;4276.978615106967;4287.142571485715;4287.249731297011;4297.3768803523935;4330;4727.220008698595;4804.447488538793;4831.589314908272;4834.444038935568;4917.754112294371;4267.3598960155605;4274.722143060691;4277.850275240414;4292.077203401283;4327.02641905575;4396.164728701537;4401.977990110029;4408.4930233023615;4409.4267745193565;4450.732956022649;4563.863084107482;4572.039871626996;4682;4684.344191813217;4772.76136193189;4935.62982776286;4945.579625731709;4957.231629097496;4959.181735013683;4965.726885021359;4708.623310135249;4708.693934894221;4713;4744.92882606768;4750;4654.720716757005;4745.738984355756;4770.761461926959;4772.331873537777;4898.436679781871;4928.0390323886495;4935.777889995031;4949.133901567283;4955.331030311006;4957.206846904478;4811.109944660249;4813.927791083067;4817.349657796152;4845.6608037437045;4855.927161092657;4637.350770892145;4755.239161734106;4761.880952976203;4770.356001939694;4808.7595620219545;4691.08523837862;4703.788329525111;4706.435227772689;4734.218853889208;4747.074320507468;4819.325294458708;4822.324874517641;4823.903521929472;4830.009847981226;4863.294822250825;4457.598816106566;4510.977445112885;4567.06375193078;4580.358749774968;4755.690880092783 04:25:15 INFO - PROCESS | 12186 | |1;ext.html;516.0942545832065;524.5436470270864;525.8685328667833;528.4979269693791;535.5126834580533;26421.867890660546;36332.273354532896;37083.81458092709;37109.62890371095;37121;40638;41148.38277425841;41259.381109283386;41287.79356103215;41389.17221655573;6878.277780833016;6989.370956613904;7819.804504887381;7994.400419968497;7994.680212791482;9966.750831229205;10313.690589282334;10320.741981450448;10323.535440905178;10324.638637647684;9975.052370024872;10030.297879148462;10078.84881726771;10081.042300981431;10094.798104037915;7051.118610173703;7185.856282874313;7191.676374563157;7203.675834587456;10061.849072263922;7009.264027277113;10141.2394070445;10319.690409287734;10457.686269411854;10471.371717696886;37068;37517;37525.437118443246;37542;37563.62436375656;2817.1548535439492;2847.2312475631466;2873.396586716792;2927.399883023975;3351.8826841060445;28995.855020724972;29398.027636882747;29416.70583294161;29543.852280738673;29876.70123298761;3320.269540701042;3331.433656278414;3364.4953257011643;3381.7970921744773;3472.322897035079;213196;214996;215119;215482;215899.99999999843;50823.23765143526;52495.73752131215;52617;53769.462305376444;56060;49222;49226.50773492291;49444.505554944706;49472.25791613129;49520.75239623779;13635.113717608323;13815.516456923959;13823.447062117604;13854.86145138556;13878.930605346908;9646.951765241269;9741.853872191923;9746.75633109178;9756;9785.168260697921;18987;19303.710444343345;19308.4207473776;19329.226830926604;19362.80637193638;7171.462140339496;7414.777556673308;7436.1820199777985;7446.66490007951;7448.553086814808;810.0441479054772;812.3988248695922;839.8908141941508;916;941.9952900235455;26142;27019.864900675762;27404.58893116565;27582;27678.861605692244;913.0139449394638;932.3659911260409;939.3800091939287;939.8872135343803;940.041158018817;13296.867031329757;13603.31983400826;13965.301734913417;14665.120092794466;14889.329980150702;254452;256182;257977;259497;261491;46002.53997460049;46227;46271.30593041107;46284.7685761569;46349;1173.049829637979;1186.2882270637722;1192.6243233381458;1204.6265657646159;1213.969650758738;26571.60142597824;27224.319392015357;27354.863225683745;27853.16440506788;27863.860680696467;40476.39285410662;40642.390364145154;40647.796761016005;40858.591414086666;40920;239570;242246;242535;315075;322720;26402.471950561267;26474.602880956416;26482.470350592495;26504.469910602067;26897.731022689524;35942.640573593926;35985.46021809727;36658;37095;39922.600773991886;33353;33648.18058762637;34006.3198736019;34484.310313794085;34784;33976.32047359089;34114.31771364609;34453.82773086119;34516.82741586276;34573.827130864185;33350.33299334048;34519.30961380708;34699.82650086733;34765.13087172841;34794.478082828275;28794.28014299659;30995.0701478956;31238.687613124486;31368.686313136575;31419.84290078535;24143.758562414852;24175;24223.878880605484;24486.510269794147;25463.74536254614 04:25:15 INFO - PROCESS | 12186 | |2;jquery.html;288.2045554270214;299.48339115026585;303.617442023051;308.714439143792;310.1563746609222;12477.875221247785;12793;14669.486567970123;15082.999999999985;15234.390624375026;14990.175540345277;15380.230988450561;15767.211639418012;15842.683146337067;15889.682206355867;4861.392325959264;4902.2156454967035;4991.101601711691;4999.825006124786;5005.749712514378;3660.1764602964386;3790.5261842269715;3795.3737633290475;5052.823151189709;5481.205225242337;5571.665700057989;5586.050371436845;5603.187537807036;5630.09918413054;5632.986062508747;5486.972565137189;5652;5662.745176467069;5664.376918538957;5667.093265077568;4934.827281045146;4936.062148191832;4936.358273424467;4950.554450099508;4953.0836795192645;19104.522386940298;19986.300479483147;20069.39791806248;21127;22097.116115355526;1829.0763164601924;1886.981130188708;1927.8457723382096;1976.5849171673965;1980.9504762381055;13880.93059534706;13883.861161388359;13887;14042.4553299137;14466.49367272151;1942.9028548572514;2023.4435530229157;2032.8334915530538;2057.7324947756697;2122.649762789138;60282.09576856351;62125.37874621286;62538.68730656317;62841.68579157121;63951.36048639547;15639.921800390925;15698.136602486744;15716.764248536281;15721.606959826096;15780.68438631244;22877.88561057184;22953;23145.768542314698;23184.65223021656;23222.65166022511;8217.79455513617;8312.501249925024;8327.125651806595;8346.457480263764;8424.620892059873;6654.26803051664;6664.766733164316;6679.966600166968;6711.865762684719;6746.662666866637;7715.498492597963;7732.845343093107;7739.303462688273;7742.109657389472;7778.377729781604;1688.21498003429;1690.129583264595;1694.669539439822;1700.9319627214772;2131.997960958347;863.8272345530793;886.8093359927647;934.5327336331834;943.3019565521602;970.5438443931341;14962.850371496146;15707.842921570867;16038.14520915524;16094.75857862133;16118.274677639534;811.7889348769245;813.2883726739103;815.7919730468692;825.2160447574828;834.8079941613463;8628.137186281447;9035.774105647411;9134.269258459308;9164.633414663473;9267.304952128618;408426;412047;415846;441391;451472;71668;71717.6414117926;75176.62411688016;75624;75673;1010.8938561451089;1037.7180153021159;1065.760203954104;1067.8878717734526;1073.4096247064083;14394.136351818925;14462.339839539822;14524.572037633658;14600.196989165697;14936.925315373353;33041;33099.17252068718;33910;34047.65952340445;34536;43597.56402435935;44001.77999109984;44373.33439998467;45143.7742811297;47461.7626911877;8552.529610871461;8605.182507661762;8805.779855503664;8813.42712723671;8822.735317940473;10496.317739346918;10501.474926253504;10545.57817687284;13758.587242382744;16408.425705100264;13395.665108372368;13660.590182294547;13920.860791392362;13956;13984.160950343012;12953.287569183409;13252;13417.792398684165;13510.527131550349;13719.314034298046;13292.335383230606;13544.932275338955;13620.591382258548;13810.930945345612;14122.293885305899;8631.956840215758;8709.216170544682;8727.389082764146;8777.210051095177;8777.253933415732;13187.53843615469;13429.127106738031;13676.31618419095;13880.583582492542;13955.511557095453 04:25:15 INFO - PROCESS | 12186 | |3;mootools.html;1433.0470237292202;1462.1884853906085;1476.5348915091745;1584.738518144506;1666.366780623363;6065.666388348639;6821.147356580427;7077.150741910978;7157.391621712148;7159.713611455535;6861.382475577197;6996.685149168287;7000.544964577299;7001.2998700129965;7011.368976792088;1669.6410271791563;1715.4510556621885;1989.0850208903921;2006.9096890639883;2021.5855749571303;2037.7554693436734;2043.3563427520282;2045.0592727345438;2045.6215600114026;2047.3141497598322;1947.4449781812186;1980.2870966452065;1983.702444633302;1984.9603007939832;1986.4437957371958;2004.7193392924855;2019.5153163240716;2021.3834780391974;2052.5792212596457;2052.733144691188;2049.4876280929766;2065.0707181768266;2065.297798748433;2066.700328452366;2066.927657531994;7108.431325494;7167.569945803269;7193.3166349196745;7202.387797037206;7202.927970720278;4112.670986321117;4202.894927626803;4209.957900420987;4212.599803018708;4212.7472351659;2502.4744803591266;2595.5587550116525;2600.7659310661943;2602.6746656667915;2628.4743051389605;770.4645271536284;772.8995230619984;785.1206648553599;785.8506883692137;798.4131663227581;9712;9737.464439455827;9763.218942484584;9772.755681107958;9777.90222097777;3727.347714150013;3785.9242815143543;3805.809709514513;3806.8286927088348;3862;8332.50004999702;8365.874511882326;8391.16088391156;8394.496330220085;8405.411621186458;4198.412222288882;4209.368594710818;4214.831406743757;4216;4216.936745948813;3841.2125514269505;3841.8079096045085;3844.3272427325105;3848.3265428550453;3852.460655508231;2971.4948458762065;3007.1129016940054;3014.351914338428;3058;3321.219513414394;1036.5024788101603;1054.7995880782628;1059.2849826367171;1062.1874266186373;1074.2211896375065;856.952867592276;868.6221493650282;886.7650072730731;888.6534251641865;891.9152680495342;6641.767538136142;6767.526273160832;6780.050792888999;6792.864142717118;6808.148981377328;1012.7569383348091;1036.730450082984;1042.588177669816;1049.8267785815408;1050.9208020499857;4881.365422495053;4910;4910.754462276872;4921.040397122527;4923.75381230937;8520.318374530023;8539.957300213458;8717.825643487095;8727.647214681734;8752.56237188138;8533.146685331418;8540.975082989957;8557.315414766803;8618.439801412887;8636.093210212963;6808.08090907731;6818.215905170969;6885.690143943534;6939.201991771011;6946.6179360134665;6482.254540727877;6522.902156467751;6524.641144737085;6531.836704082436;6552.770653027121;7698.07623085211;7827;7902.604869756604;7928.365730741411;8011.799705007422;7724.92275077242;7794.415418843496;7873.330766884879;8085.797855053671;8183.140770219041;6379.362063793584;6474.773382931575;6476.31998640136;6479.222493300834;6485.448736857231;6861.382475577222;6896.103506544117;6924.896126558005;6987.02181694553;7008.439324854102;6310.6844657766005;6332.683365831782;6337.081123237012;6352.36476352361;6486.578372405778;6213.751449942132;6327.462165715781;6400.039994000751;6495.350464953656;6566.967165164144;6563.343665633399;6580.80257592273;6633.834154146185;6659.2008958925235;6666.733330666719;6087.147799308189;6118.847028824315;6119.051547010221;6133.3866613338305;6140.1710769047395;5903.49820265265;6026.517878569616;6031.09533569968;6145.231846019247;6201.658908760061 04:25:15 INFO - PROCESS | 12186 | |4;prototype.html;270.9525832979229;276.17423902531436;277.88884446221516;286.0545895814334;287.22449386656035;5043.420006699231;5307.20391941209;5365.543928766055;5383.784648614051;5391.919121213185;5221.39953905301;5309.8938021239555;5310.6017048721305;5325.600579956509;5340.412554618989;4100.938485922706;4115.238680844039;4123.3196522573735;4123.731957422773;4129.112240868213;4115.444415003981;4119.938200926988;4121.093359460914;4124.340105583107;4124.917501649965;4079.2453396121664;4082.448869402622;4085.1829634073156;4088.89777755557;4090;3976.4234186043004;4064.288749468831;4064.5325787534516;4068.4914385701786;4073.4500842386196;3528.0121565961317;3529.8764543240864;3530.470429435605;3537.3809583322814;3542.1144713821545;5119.180931051052;5123.820666276662;5123.974380128113;5130.230465430215;5137.743112844343;4655.534446555352;4658.068386322749;4659.767011649438;4662.487126416091;4665.510121437234;5282.577393808525;5438.510534051954;5501.092319767234;5600.6079574429805;5609.775608975636;3712.4988126602834;3718.4050551911564;3719.20037192005;3720.6465385788306;3721.702263818888;5536.114221724545;5742.856428589319;5745.454181852759;5833.883322333572;5839.065749480105;3759.962400376016;3822.063594419385;3906.90232744178;3914.706397020235;3921.137349783043;3938.6455219030427;3960.089179488676;3965.722399432012;3967.6429121379215;3970.4242884781543;4358.956410435919;4455.131249406335;4515.706479078849;4573.519780423074;4597.448306203277;5556.722163891789;5573.749181286852;5582.972085139549;5585.69278689676;5586.050371436784;1391.1374947532595;1417.6314158318705;1419.0917812599944;1420.4460260498413;1422.0472283570032;919.5264438814016;920.7375897869075;939.1594522901964;940.5955439161089;950.1068995144542;4917.409910810726;4923.581495572845;4927.211646136672;4933.3586633738105;4936.259561065869;5785.652860828363;5785.971070144622;5788.131780232915;5791.218185544897;5791.391903850119;4910.533499317559;4914.606831453475;4915.311856340115;4918.286848406961;4923.77842997066;3015.8492075396143;3074.969250307513;3106.5340198970334;3112.3308488675043;3115.6417012043903;5521.917171242435;5545.140503222007;5557.499825015768;5557.722113894289;5558.360788509292;5959.645939853734;5989.610675306091;5992.790252341147;5999.940000600025;6048.576599637983;5536.667799931856;5538.667679939216;5541.418151094158;5542.8337149885565;5544.91682624761;5669.7165141741925;5778.451047150514;5822.854428639149;5824.155497452761;5831.446012628793;5698.375962850568;5703.828885133453;5708.115242137475;5708.229389032594;5709.343425505954;5532.861678458071;5536.91694624589;5537.280153580009;5538.418466061005;5538.529225015757;3744.382176940774;3802.8478860845257;3825.1393436477683;3838.7120965928225;3838.9616103838603;5598.1322894951345;5740.598158129058;5747.051736463437;5778.248827652378;5781.4218578141845;5449.100898351728;5592.636478628876;5619.201855406231;5627.5497960162265;5634.154876768517;5592.245046918614;5592.580556458201;5597.496225339576;5598.692071936082;5602.215689803512;5369.248305237192;5487.847552013962;5493.945060549343;5495.093309603871;5496.80761173357;5592.972035139798;5623.915641265303;5635.633683810539;5647.7176141193595;5650.378458369494;5445.618806683494;5455.1544510600925;5480.479354461319;5500.147477141049;5523.944760552343 04:25:15 INFO - PROCESS | 12186 | |5;yui.html;650.5153660522908;711.2745000099899;711.8608581213452;773.400614523744;774.2953911940135;10878.184136189788;11064;11107.166962477826;11125.888741112587;11148.721281967944;11057;11353.545858165664;11371.943140284287;11409.37248451335;12389.938050309758;798.660569258066;812.8008637883727;813.9674413023472;814.250889181954;814.6293436486385;801.9238172373615;809.7489778168787;809.8623234050226;809.9028116626013;810.9229623185788;841.9073901870789;850.8340873529664;850.8808766772656;851.1573542193246;852.2542775071812;842.473454091193;842.9030661473917;843.7342237195326;845.0788640381983;849.1084361420484;633.7084940927133;635.0220660183312;635.034747184282;635.4725577770439;635.4852569418786;11687.649370518899;11785.410729463492;11803;11808;11817.645470635809;11163.553457861675;11494.42527873603;11585.131115166312;11709.590164344292;11836.822447663291;9056.230220431271;9131.086891310882;9211.723648290563;9241.584128714157;9291.72124836256;3234.4663130583426;3298.4887342461716;3336.432806422914;3338.5159151923076;3405.080628230389;34035.82982085099;34694.65305346965;37407;37879.62120378816;38155.23689526222;9081.500517471603;9183.494907780003;9197.402168859002;9268.304877134242;9538.046195380546;14544.709105818036;14955.327010284564;14993.475228366955;15006;15025.774613380809;6381.4575761059905;6387.616742995435;6465.321141280192;6558.409743123142;6629.11070344959;3599.7300202484917;3644.726645501598;3658.981705091511;3689.3728066228805;3721.4789929409903;2438.6585877977095;2445.5597992361545;2450.571150048734;2457.9062317268645;2461.040194324215;471.6156332588929;472.43072098121684;480.2556038140937;481.4992407895749;488.64573184440997;520.2794130129797;590.5983930927011;599.95800293979;604.268834709997;612.4824523277823;7028.1917579477995;7226.819329516804;7301.08736407949;7325.084364454443;7416.110066792019;439.7559354558187;555.9583031272671;585.7416581452815;614.9385061493815;621.8942779727457;3440.6559344065395;3572.98213508936;3577.463380492895;3960.881173564798;4073;42678.35982460265;42883.57116428858;43005.78497107494;43040.13919721588;43077.56922430798;41701;41794.79102604467;42133.78933105315;42497;42543.57456425396;32546;33480.83259583735;34529.30941381209;35901.8204908979;40106.39840402397;7682.539047657158;7824.608769561613;7833.804154895945;8000.6399712011935;8058.798530036796;30338.393232135677;30742.385152297276;30800.69199308068;32325.838370807996;33123.171920701214;37470.250594988494;37852.621473786014;37861.81069094637;38981.6101838978;41780;10686.89313106859;10835.133189344991;10931.18016148776;10957.780844382909;11246.357106080228;10763.94618026905;10867.456627168453;10943.01512863846;11007.83488247693;11156.330620162817;10492.422916739653;10602.363858168535;10693.144548436261;10945.83581246266;11311.830322545004;10488;10839.187060970617;11044.613438529614;11050.33697978124;11280.661580152608;9883.703488895344;10108.090271875566;10339.172866170838;10419.218558608287;10484.108850747467;8837.293016558788;9063.456192628464;9335.626574936927;9351.812963740824;9528.380655257386;8822.161894620001;8919.464832110094;9277.721668349961;9281.62873485053;9292.72121836346 04:25:15 INFO - PROCESS | 12186 | __end_tp_report 04:25:15 INFO - PROCESS | 12186 | __start_cc_report 04:25:15 INFO - PROCESS | 12186 | _x_x_mozilla_cycle_collect,915 04:25:15 INFO - PROCESS | 12186 | __end_cc_report 04:25:15 INFO - PROCESS | 12186 | __startTimestamp1450787115860__endTimestamp 04:25:15 INFO - PROCESS | 12186 | 04:25:15 INFO - PROCESS | 12186 | ------- Summary: start ------- 04:25:15 INFO - PROCESS | 12186 | Number of tests: 6 04:25:15 INFO - PROCESS | 12186 | 04:25:15 INFO - PROCESS | 12186 | [#0] dojo.html Cycles:165 Average:4532.15 Median:4654.72 stddev:462.98 (9.9%) stddev-sans-first:438.28 04:25:15 INFO - PROCESS | 12186 | Values: 2578.1 2656.6 2663.2 2679.5 2681.9 4417.2 4521.8 4544.4 4581.7 4590.6 4553.2 4595.7 4618.7 4632.5 4652.9 4100.0 4138.2 4300.7 4361.2 4373.4 4109.0 4198.5 4310.4 4332.6 4369.8 4135.5 4172.6 4202.0 4224.0 4248.2 4238.5 4263.2 4265.6 4306.0 4312.2 4101.0 4219.6 4260.1 4260.5 4313.9 4387.2 4491.7 4499.8 4519.1 4539.4 4915.1 4920.9 4923.1 4923.5 4977.0 4698.5 4945.5 4945.7 4958.2 4994.1 4484.5 4486.7 4502.9 4586.1 4644.7 5031.9 5048.1 5048.7 5051.7 5101.8 4696.1 4842.0 4847.9 4848.0 4890.6 4805.5 4855.9 4858.1 4861.1 4918.0 4866.2 4870.9 4872.9 4875.9 4911.9 4686.3 4841.5 4845.3 4849.6 4898.3 3991.8 4036.5 4052.2 4052.3 4076.5 3589.5 3607.5 3615.1 3648.0 3661.4 4277.0 4287.1 4287.2 4297.4 4330.0 4727.2 4804.4 4831.6 4834.4 4917.8 4267.4 4274.7 4277.9 4292.1 4327.0 4396.2 4402.0 4408.5 4409.4 4450.7 4563.9 4572.0 4682.0 4684.3 4772.8 4935.6 4945.6 4957.2 4959.2 4965.7 4708.6 4708.7 4713.0 4744.9 4750.0 4654.7 4745.7 4770.8 4772.3 4898.4 4928.0 4935.8 4949.1 4955.3 4957.2 4811.1 4813.9 4817.3 4845.7 4855.9 4637.4 4755.2 4761.9 4770.4 4808.8 4691.1 4703.8 4706.4 4734.2 4747.1 4819.3 4822.3 4823.9 4830.0 4863.3 4457.6 4511.0 4567.1 4580.4 4755.7 04:25:15 INFO - PROCESS | 12186 | 04:25:15 INFO - PROCESS | 12186 | [#1] ext.html Cycles:180 Average:40923.80 Median:18679.06 stddev:65235.04 (349.2%) stddev-sans-first:65347.49 04:25:15 INFO - PROCESS | 12186 | Values: 516.1 524.5 525.9 528.5 535.5 26421.9 36332.3 37083.8 37109.6 37121.0 40638.0 41148.4 41259.4 41287.8 41389.2 6878.3 6989.4 7819.8 7994.4 7994.7 9966.8 10313.7 10320.7 10323.5 10324.6 9975.1 10030.3 10078.8 10081.0 10094.8 7051.1 7185.9 7191.7 7203.7 10061.8 7009.3 10141.2 10319.7 10457.7 10471.4 37068.0 37517.0 37525.4 37542.0 37563.6 2817.2 2847.2 2873.4 2927.4 3351.9 28995.9 29398.0 29416.7 29543.9 29876.7 3320.3 3331.4 3364.5 3381.8 3472.3 213196.0 214996.0 215119.0 215482.0 215900.0 50823.2 52495.7 52617.0 53769.5 56060.0 49222.0 49226.5 49444.5 49472.3 49520.8 13635.1 13815.5 13823.4 13854.9 13878.9 9647.0 9741.9 9746.8 9756.0 9785.2 18987.0 19303.7 19308.4 19329.2 19362.8 7171.5 7414.8 7436.2 7446.7 7448.6 810.0 812.4 839.9 916.0 942.0 26142.0 27019.9 27404.6 27582.0 27678.9 913.0 932.4 939.4 939.9 940.0 13296.9 13603.3 13965.3 14665.1 14889.3 254452.0 256182.0 257977.0 259497.0 261491.0 46002.5 46227.0 46271.3 46284.8 46349.0 1173.0 1186.3 1192.6 1204.6 1214.0 26571.6 27224.3 27354.9 27853.2 27863.9 40476.4 40642.4 40647.8 40858.6 40920.0 239570.0 242246.0 242535.0 315075.0 322720.0 26402.5 26474.6 26482.5 26504.5 26897.7 35942.6 35985.5 36658.0 37095.0 39922.6 33353.0 33648.2 34006.3 34484.3 34784.0 33976.3 34114.3 34453.8 34516.8 34573.8 33350.3 34519.3 34699.8 34765.1 34794.5 28794.3 30995.1 31238.7 31368.7 31419.8 24143.8 24175.0 24223.9 24486.5 25463.7 04:25:15 INFO - PROCESS | 12186 | 04:25:15 INFO - PROCESS | 12186 | [#2] jquery.html Cycles:180 Average:25679.20 Median:33070.09 stddev:69750.27 (210.9%) stddev-sans-first:69919.88 04:25:15 INFO - PROCESS | 12186 | Values: 288.2 299.5 303.6 308.7 310.2 12477.9 12793.0 14669.5 15083.0 15234.4 14990.2 15380.2 15767.2 15842.7 15889.7 4861.4 4902.2 4991.1 4999.8 5005.7 3660.2 3790.5 3795.4 5052.8 5481.2 5571.7 5586.1 5603.2 5630.1 5633.0 5487.0 5652.0 5662.7 5664.4 5667.1 4934.8 4936.1 4936.4 4950.6 4953.1 19104.5 19986.3 20069.4 21127.0 22097.1 1829.1 1887.0 1927.8 1976.6 1981.0 13880.9 13883.9 13887.0 14042.5 14466.5 1942.9 2023.4 2032.8 2057.7 2122.6 60282.1 62125.4 62538.7 62841.7 63951.4 15639.9 15698.1 15716.8 15721.6 15780.7 22877.9 22953.0 23145.8 23184.7 23222.7 8217.8 8312.5 8327.1 8346.5 8424.6 6654.3 6664.8 6680.0 6711.9 6746.7 7715.5 7732.8 7739.3 7742.1 7778.4 1688.2 1690.1 1694.7 1700.9 2132.0 863.8 886.8 934.5 943.3 970.5 14962.9 15707.8 16038.1 16094.8 16118.3 811.8 813.3 815.8 825.2 834.8 8628.1 9035.8 9134.3 9164.6 9267.3 408426.0 412047.0 415846.0 441391.0 451472.0 71668.0 71717.6 75176.6 75624.0 75673.0 1010.9 1037.7 1065.8 1067.9 1073.4 14394.1 14462.3 14524.6 14600.2 14936.9 33041.0 33099.2 33910.0 34047.7 34536.0 43597.6 44001.8 44373.3 45143.8 47461.8 8552.5 8605.2 8805.8 8813.4 8822.7 10496.3 10501.5 10545.6 13758.6 16408.4 13395.7 13660.6 13920.9 13956.0 13984.2 12953.3 13252.0 13417.8 13510.5 13719.3 13292.3 13544.9 13620.6 13810.9 14122.3 8632.0 8709.2 8727.4 8777.2 8777.3 13187.5 13429.1 13676.3 13880.6 13955.5 04:25:15 INFO - PROCESS | 12186 | 04:25:15 INFO - PROCESS | 12186 | [#3] mootools.html Cycles:180 Average:4977.29 Median:6344.72 stddev:2641.34 (41.6%) stddev-sans-first:2635.31 04:25:15 INFO - PROCESS | 12186 | Values: 1433.0 1462.2 1476.5 1584.7 1666.4 6065.7 6821.1 7077.2 7157.4 7159.7 6861.4 6996.7 7000.5 7001.3 7011.4 1669.6 1715.5 1989.1 2006.9 2021.6 2037.8 2043.4 2045.1 2045.6 2047.3 1947.4 1980.3 1983.7 1985.0 1986.4 2004.7 2019.5 2021.4 2052.6 2052.7 2049.5 2065.1 2065.3 2066.7 2066.9 7108.4 7167.6 7193.3 7202.4 7202.9 4112.7 4202.9 4210.0 4212.6 4212.7 2502.5 2595.6 2600.8 2602.7 2628.5 770.5 772.9 785.1 785.9 798.4 9712.0 9737.5 9763.2 9772.8 9777.9 3727.3 3785.9 3805.8 3806.8 3862.0 8332.5 8365.9 8391.2 8394.5 8405.4 4198.4 4209.4 4214.8 4216.0 4216.9 3841.2 3841.8 3844.3 3848.3 3852.5 2971.5 3007.1 3014.4 3058.0 3321.2 1036.5 1054.8 1059.3 1062.2 1074.2 857.0 868.6 886.8 888.7 891.9 6641.8 6767.5 6780.1 6792.9 6808.1 1012.8 1036.7 1042.6 1049.8 1050.9 4881.4 4910.0 4910.8 4921.0 4923.8 8520.3 8540.0 8717.8 8727.6 8752.6 8533.1 8541.0 8557.3 8618.4 8636.1 6808.1 6818.2 6885.7 6939.2 6946.6 6482.3 6522.9 6524.6 6531.8 6552.8 7698.1 7827.0 7902.6 7928.4 8011.8 7724.9 7794.4 7873.3 8085.8 8183.1 6379.4 6474.8 6476.3 6479.2 6485.4 6861.4 6896.1 6924.9 6987.0 7008.4 6310.7 6332.7 6337.1 6352.4 6486.6 6213.8 6327.5 6400.0 6495.4 6567.0 6563.3 6580.8 6633.8 6659.2 6666.7 6087.1 6118.8 6119.1 6133.4 6140.2 5903.5 6026.5 6031.1 6145.2 6201.7 04:25:15 INFO - PROCESS | 12186 | 04:25:15 INFO - PROCESS | 12186 | [#4] prototype.html Cycles:180 Average:4608.40 Median:5318.10 stddev:1379.69 (25.9%) stddev-sans-first:1344.61 04:25:15 INFO - PROCESS | 12186 | Values: 271.0 276.2 277.9 286.1 287.2 5043.4 5307.2 5365.5 5383.8 5391.9 5221.4 5309.9 5310.6 5325.6 5340.4 4100.9 4115.2 4123.3 4123.7 4129.1 4115.4 4119.9 4121.1 4124.3 4124.9 4079.2 4082.4 4085.2 4088.9 4090.0 3976.4 4064.3 4064.5 4068.5 4073.5 3528.0 3529.9 3530.5 3537.4 3542.1 5119.2 5123.8 5124.0 5130.2 5137.7 4655.5 4658.1 4659.8 4662.5 4665.5 5282.6 5438.5 5501.1 5600.6 5609.8 3712.5 3718.4 3719.2 3720.6 3721.7 5536.1 5742.9 5745.5 5833.9 5839.1 3760.0 3822.1 3906.9 3914.7 3921.1 3938.6 3960.1 3965.7 3967.6 3970.4 4359.0 4455.1 4515.7 4573.5 4597.4 5556.7 5573.7 5583.0 5585.7 5586.1 1391.1 1417.6 1419.1 1420.4 1422.0 919.5 920.7 939.2 940.6 950.1 4917.4 4923.6 4927.2 4933.4 4936.3 5785.7 5786.0 5788.1 5791.2 5791.4 4910.5 4914.6 4915.3 4918.3 4923.8 3015.8 3075.0 3106.5 3112.3 3115.6 5521.9 5545.1 5557.5 5557.7 5558.4 5959.6 5989.6 5992.8 5999.9 6048.6 5536.7 5538.7 5541.4 5542.8 5544.9 5669.7 5778.5 5822.9 5824.2 5831.4 5698.4 5703.8 5708.1 5708.2 5709.3 5532.9 5536.9 5537.3 5538.4 5538.5 3744.4 3802.8 3825.1 3838.7 3839.0 5598.1 5740.6 5747.1 5778.2 5781.4 5449.1 5592.6 5619.2 5627.5 5634.2 5592.2 5592.6 5597.5 5598.7 5602.2 5369.2 5487.8 5493.9 5495.1 5496.8 5593.0 5623.9 5635.6 5647.7 5650.4 5445.6 5455.2 5480.5 5500.1 5523.9 04:25:15 INFO - PROCESS | 12186 | 04:25:15 INFO - PROCESS | 12186 | [#5] yui.html Cycles:180 Average:11656.72 Median:41964.29 stddev:12601.97 (30.0%) stddev-sans-first:12610.22 04:25:15 INFO - PROCESS | 12186 | Values: 650.5 711.3 711.9 773.4 774.3 10878.2 11064.0 11107.2 11125.9 11148.7 11057.0 11353.5 11371.9 11409.4 12389.9 798.7 812.8 814.0 814.3 814.6 801.9 809.7 809.9 809.9 810.9 841.9 850.8 850.9 851.2 852.3 842.5 842.9 843.7 845.1 849.1 633.7 635.0 635.0 635.5 635.5 11687.6 11785.4 11803.0 11808.0 11817.6 11163.6 11494.4 11585.1 11709.6 11836.8 9056.2 9131.1 9211.7 9241.6 9291.7 3234.5 3298.5 3336.4 3338.5 3405.1 34035.8 34694.7 37407.0 37879.6 38155.2 9081.5 9183.5 9197.4 9268.3 9538.0 14544.7 14955.3 14993.5 15006.0 15025.8 6381.5 6387.6 6465.3 6558.4 6629.1 3599.7 3644.7 3659.0 3689.4 3721.5 2438.7 2445.6 2450.6 2457.9 2461.0 471.6 472.4 480.3 481.5 488.6 520.3 590.6 600.0 604.3 612.5 7028.2 7226.8 7301.1 7325.1 7416.1 439.8 556.0 585.7 614.9 621.9 3440.7 3573.0 3577.5 3960.9 4073.0 42678.4 42883.6 43005.8 43040.1 43077.6 41701.0 41794.8 42133.8 42497.0 42543.6 32546.0 33480.8 34529.3 35901.8 40106.4 7682.5 7824.6 7833.8 8000.6 8058.8 30338.4 30742.4 30800.7 32325.8 33123.2 37470.3 37852.6 37861.8 38981.6 41780.0 10686.9 10835.1 10931.2 10957.8 11246.4 10763.9 10867.5 10943.0 11007.8 11156.3 10492.4 10602.4 10693.1 10945.8 11311.8 10488.0 10839.2 11044.6 11050.3 11280.7 9883.7 10108.1 10339.2 10419.2 10484.1 8837.3 9063.5 9335.6 9351.8 9528.4 8822.2 8919.5 9277.7 9281.6 9292.7 04:25:15 INFO - PROCESS | 12186 | -------- Summary: end -------- 04:25:15 INFO - PROCESS | 12186 | 04:25:16 INFO - TEST-INFO | 12186: exit 0 04:25:16 INFO - TEST-OK | dromaeo_css | took 1117769ms 04:25:16 INFO - TEST-START | kraken 04:25:16 INFO - operating with platform_type : linux_ 04:25:16 INFO - Initialising browser for kraken test... 04:25:16 INFO - TEST-INFO | started process 12385 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCNocL0/profile http://localhost:37352/getInfo.html) 04:25:20 INFO - PROCESS | 12385 | JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 04:25:20 INFO - PROCESS | 12385 | __metrics Screen width/height:1600/1200 04:25:20 INFO - PROCESS | 12385 | colorDepth:24 04:25:20 INFO - PROCESS | 12385 | Browser inner width/height: 1024/697 04:25:20 INFO - PROCESS | 12385 | __metrics 04:25:21 INFO - PROCESS | 12385 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:25:21 INFO - PROCESS | 12385 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:25:22 INFO - TEST-INFO | 12385: exit 0 04:25:22 INFO - Browser initialized. 04:25:22 INFO - Running cycle 1/1 for kraken test... 04:25:22 INFO - TEST-INFO | started process 12466 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCNocL0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:25:34 INFO - PROCESS | 12466 | RSS: Main: 149463040 04:25:34 INFO - PROCESS | 12466 | 04:25:36 INFO - PROCESS | 12466 | Cycle 1(1): loaded http://localhost:37352/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37352/tests/kraken/driver.html?testName=audio-beat-detection) 04:25:37 INFO - PROCESS | 12466 | RSS: Main: 183672832 04:25:37 INFO - PROCESS | 12466 | 04:25:40 INFO - PROCESS | 12466 | Cycle 1(1): loaded http://localhost:37352/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37352/tests/kraken/driver.html?testName=audio-dft) 04:25:40 INFO - PROCESS | 12466 | RSS: Main: 173305856 04:25:40 INFO - PROCESS | 12466 | 04:25:43 INFO - PROCESS | 12466 | Cycle 1(1): loaded http://localhost:37352/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37352/tests/kraken/driver.html?testName=audio-fft) 04:25:44 INFO - PROCESS | 12466 | RSS: Main: 160595968 04:25:44 INFO - PROCESS | 12466 | 04:25:46 INFO - PROCESS | 12466 | Cycle 1(1): loaded http://localhost:37352/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37352/tests/kraken/driver.html?testName=audio-oscillator) 04:25:47 INFO - PROCESS | 12466 | RSS: Main: 163368960 04:25:47 INFO - PROCESS | 12466 | 04:25:49 INFO - PROCESS | 12466 | Cycle 1(1): loaded http://localhost:37352/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37352/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:25:49 INFO - PROCESS | 12466 | RSS: Main: 166236160 04:25:49 INFO - PROCESS | 12466 | 04:25:52 INFO - PROCESS | 12466 | Cycle 1(1): loaded http://localhost:37352/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37352/tests/kraken/driver.html?testName=imaging-darkroom) 04:25:53 INFO - PROCESS | 12466 | RSS: Main: 164339712 04:25:53 INFO - PROCESS | 12466 | 04:25:56 INFO - PROCESS | 12466 | Cycle 1(1): loaded http://localhost:37352/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37352/tests/kraken/driver.html?testName=imaging-desaturate) 04:25:57 INFO - PROCESS | 12466 | RSS: Main: 165322752 04:25:57 INFO - PROCESS | 12466 | 04:26:00 INFO - PROCESS | 12466 | Cycle 1(1): loaded http://localhost:37352/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37352/tests/kraken/driver.html?testName=json-parse-financial) 04:26:00 INFO - PROCESS | 12466 | RSS: Main: 165761024 04:26:00 INFO - PROCESS | 12466 | 04:26:02 INFO - PROCESS | 12466 | Cycle 1(1): loaded http://localhost:37352/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37352/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:26:03 INFO - PROCESS | 12466 | RSS: Main: 173551616 04:26:03 INFO - PROCESS | 12466 | 04:26:05 INFO - PROCESS | 12466 | Cycle 1(1): loaded http://localhost:37352/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37352/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:26:05 INFO - PROCESS | 12466 | RSS: Main: 171761664 04:26:05 INFO - PROCESS | 12466 | 04:26:07 INFO - PROCESS | 12466 | Cycle 1(1): loaded http://localhost:37352/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37352/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:26:08 INFO - PROCESS | 12466 | RSS: Main: 187166720 04:26:08 INFO - PROCESS | 12466 | 04:26:11 INFO - PROCESS | 12466 | Cycle 1(1): loaded http://localhost:37352/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37352/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:26:11 INFO - PROCESS | 12466 | RSS: Main: 191361024 04:26:11 INFO - PROCESS | 12466 | 04:26:14 INFO - PROCESS | 12466 | Cycle 1(1): loaded http://localhost:37352/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37352/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:26:14 INFO - PROCESS | 12466 | RSS: Main: 188936192 04:26:14 INFO - PROCESS | 12466 | 04:26:16 INFO - PROCESS | 12466 | Cycle 1(1): loaded http://localhost:37352/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37352/tests/kraken/driver.html?testName=ai-astar) 04:26:16 INFO - PROCESS | 12466 | RSS: Main: 246956032 04:26:16 INFO - PROCESS | 12466 | 04:26:16 INFO - PROCESS | 12466 | __start_tp_report 04:26:16 INFO - PROCESS | 12466 | _x_x_mozilla_page_load 04:26:16 INFO - PROCESS | 12466 | _x_x_mozilla_page_load_details 04:26:16 INFO - PROCESS | 12466 | |i|pagename|runs| 04:26:16 INFO - PROCESS | 12466 | |0;ai-astar;111;115;107;113;113;112;102;113;111;104 04:26:16 INFO - PROCESS | 12466 | |1;audio-beat-detection;157;129;159;164;136;158;154;130;165;133 04:26:16 INFO - PROCESS | 12466 | |2;audio-dft;163;161;161;160;162;161;163;163;164;173 04:26:16 INFO - PROCESS | 12466 | |3;audio-fft;71;72;80;90;71;74;72;101;92;71 04:26:16 INFO - PROCESS | 12466 | |4;audio-oscillator;95;95;130;96;95;94;134;95;94;133 04:26:16 INFO - PROCESS | 12466 | |5;imaging-gaussian-blur;110;109;109;109;110;110;110;109;109;109 04:26:16 INFO - PROCESS | 12466 | |6;imaging-darkroom;146;147;148;147;148;147;147;146;149;146 04:26:16 INFO - PROCESS | 12466 | |7;imaging-desaturate;95;95;95;95;95;95;94;95;95;95 04:26:16 INFO - PROCESS | 12466 | |8;json-parse-financial;71;75;71;71;71;70;71;79;69;69 04:26:16 INFO - PROCESS | 12466 | |9;json-stringify-tinderbox;68;68;67;67;68;68;68;68;68;68 04:26:16 INFO - PROCESS | 12466 | |10;stanford-crypto-aes;82;84;83;83;83;83;83;90;91;83 04:26:16 INFO - PROCESS | 12466 | |11;stanford-crypto-ccm;130;127;125;123;123;123;124;128;124;119 04:26:16 INFO - PROCESS | 12466 | |12;stanford-crypto-pbkdf2;137;147;147;150;149;138;149;136;149;135 04:26:16 INFO - PROCESS | 12466 | |13;stanford-crypto-sha256-iterative;71;70;69;72;71;69;68;70;71;69 04:26:16 INFO - PROCESS | 12466 | __end_tp_report 04:26:16 INFO - PROCESS | 12466 | __start_cc_report 04:26:16 INFO - PROCESS | 12466 | _x_x_mozilla_cycle_collect,994 04:26:16 INFO - PROCESS | 12466 | __end_cc_report 04:26:16 INFO - PROCESS | 12466 | __startTimestamp1450787176774__endTimestamp 04:26:16 INFO - PROCESS | 12466 | 04:26:16 INFO - PROCESS | 12466 | ------- Summary: start ------- 04:26:16 INFO - PROCESS | 12466 | Number of tests: 14 04:26:16 INFO - PROCESS | 12466 | 04:26:16 INFO - PROCESS | 12466 | [#0] ai-astar Cycles:10 Average:110.10 Median:112.50 stddev:4.31 (3.8%) stddev-sans-first:4.56 04:26:16 INFO - PROCESS | 12466 | Values: 111.0 115.0 107.0 113.0 113.0 112.0 102.0 113.0 111.0 104.0 04:26:16 INFO - PROCESS | 12466 | 04:26:16 INFO - PROCESS | 12466 | [#1] audio-beat-detection Cycles:10 Average:148.50 Median:157.50 stddev:14.66 (9.3%) stddev-sans-first:15.22 04:26:16 INFO - PROCESS | 12466 | Values: 157.0 129.0 159.0 164.0 136.0 158.0 154.0 130.0 165.0 133.0 04:26:16 INFO - PROCESS | 12466 | 04:26:16 INFO - PROCESS | 12466 | [#2] audio-dft Cycles:10 Average:163.10 Median:163.00 stddev:3.70 (2.3%) stddev-sans-first:3.92 04:26:16 INFO - PROCESS | 12466 | Values: 163.0 161.0 161.0 160.0 162.0 161.0 163.0 163.0 164.0 173.0 04:26:16 INFO - PROCESS | 12466 | 04:26:16 INFO - PROCESS | 12466 | [#3] audio-fft Cycles:10 Average:79.40 Median:73.00 stddev:11.00 (15.1%) stddev-sans-first:11.24 04:26:16 INFO - PROCESS | 12466 | Values: 71.0 72.0 80.0 90.0 71.0 74.0 72.0 101.0 92.0 71.0 04:26:16 INFO - PROCESS | 12466 | 04:26:16 INFO - PROCESS | 12466 | [#4] audio-oscillator Cycles:10 Average:106.10 Median:95.00 stddev:18.14 (19.1%) stddev-sans-first:18.79 04:26:16 INFO - PROCESS | 12466 | Values: 95.0 95.0 130.0 96.0 95.0 94.0 134.0 95.0 94.0 133.0 04:26:16 INFO - PROCESS | 12466 | 04:26:16 INFO - PROCESS | 12466 | [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 04:26:16 INFO - PROCESS | 12466 | Values: 110.0 109.0 109.0 109.0 110.0 110.0 110.0 109.0 109.0 109.0 04:26:16 INFO - PROCESS | 12466 | 04:26:16 INFO - PROCESS | 12466 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.99 (0.7%) stddev-sans-first:0.97 04:26:16 INFO - PROCESS | 12466 | Values: 146.0 147.0 148.0 147.0 148.0 147.0 147.0 146.0 149.0 146.0 04:26:16 INFO - PROCESS | 12466 | 04:26:16 INFO - PROCESS | 12466 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 04:26:16 INFO - PROCESS | 12466 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 04:26:16 INFO - PROCESS | 12466 | 04:26:16 INFO - PROCESS | 12466 | [#8] json-parse-financial Cycles:10 Average:71.70 Median:71.00 stddev:3.06 (4.3%) stddev-sans-first:3.23 04:26:16 INFO - PROCESS | 12466 | Values: 71.0 75.0 71.0 71.0 71.0 70.0 71.0 79.0 69.0 69.0 04:26:16 INFO - PROCESS | 12466 | 04:26:16 INFO - PROCESS | 12466 | [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:68.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 04:26:16 INFO - PROCESS | 12466 | Values: 68.0 68.0 67.0 67.0 68.0 68.0 68.0 68.0 68.0 68.0 04:26:16 INFO - PROCESS | 12466 | 04:26:16 INFO - PROCESS | 12466 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:83.00 stddev:3.21 (3.9%) stddev-sans-first:3.27 04:26:16 INFO - PROCESS | 12466 | Values: 82.0 84.0 83.0 83.0 83.0 83.0 83.0 90.0 91.0 83.0 04:26:16 INFO - PROCESS | 12466 | 04:26:16 INFO - PROCESS | 12466 | [#11] stanford-crypto-ccm Cycles:10 Average:124.60 Median:124.50 stddev:3.10 (2.5%) stddev-sans-first:2.60 04:26:16 INFO - PROCESS | 12466 | Values: 130.0 127.0 125.0 123.0 123.0 123.0 124.0 128.0 124.0 119.0 04:26:16 INFO - PROCESS | 12466 | 04:26:16 INFO - PROCESS | 12466 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.70 Median:148.00 stddev:6.31 (4.3%) stddev-sans-first:6.21 04:26:16 INFO - PROCESS | 12466 | Values: 137.0 147.0 147.0 150.0 149.0 138.0 149.0 136.0 149.0 135.0 04:26:16 INFO - PROCESS | 12466 | 04:26:16 INFO - PROCESS | 12466 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:70.50 stddev:1.25 (1.8%) stddev-sans-first:1.27 04:26:16 INFO - PROCESS | 12466 | Values: 71.0 70.0 69.0 72.0 71.0 69.0 68.0 70.0 71.0 69.0 04:26:16 INFO - PROCESS | 12466 | -------- Summary: end -------- 04:26:16 INFO - PROCESS | 12466 | 04:26:17 INFO - TEST-INFO | 12466: exit 0 04:26:17 INFO - TEST-OK | kraken | took 61091ms 04:26:17 INFO - TEST-START | v8_7 04:26:17 INFO - operating with platform_type : linux_ 04:26:17 INFO - Initialising browser for v8_7 test... 04:26:17 INFO - TEST-INFO | started process 12716 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp726WT4/profile http://localhost:37352/getInfo.html) 04:26:22 INFO - PROCESS | 12716 | JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 04:26:22 INFO - PROCESS | 12716 | __metrics Screen width/height:1600/1200 04:26:22 INFO - PROCESS | 12716 | colorDepth:24 04:26:22 INFO - PROCESS | 12716 | Browser inner width/height: 1024/697 04:26:22 INFO - PROCESS | 12716 | __metrics 04:26:22 INFO - PROCESS | 12716 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:26:22 INFO - PROCESS | 12716 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:26:23 INFO - TEST-INFO | 12716: exit 0 04:26:23 INFO - Browser initialized. 04:26:23 INFO - Running cycle 1/1 for v8_7 test... 04:26:23 INFO - TEST-INFO | started process 12799 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp726WT4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:26:35 INFO - PROCESS | 12799 | RSS: Main: 150007808 04:26:35 INFO - PROCESS | 12799 | 04:26:57 INFO - PROCESS | 12799 | Cycle 1(1): loaded http://localhost:37352/tests/v8_7/run.html (next: http://localhost:37352/tests/v8_7/run.html) 04:26:57 INFO - PROCESS | 12799 | RSS: Main: 448753664 04:26:57 INFO - PROCESS | 12799 | 04:26:57 INFO - PROCESS | 12799 | __start_tp_report 04:26:57 INFO - PROCESS | 12799 | _x_x_mozilla_page_load 04:26:57 INFO - PROCESS | 12799 | _x_x_mozilla_page_load_details 04:26:57 INFO - PROCESS | 12799 | |i|pagename|runs| 04:26:57 INFO - PROCESS | 12799 | |0;Richards;170.24174327545114 04:26:57 INFO - PROCESS | 12799 | |1;DeltaBlue;187.72292096865027 04:26:57 INFO - PROCESS | 12799 | |2;Encrypt;278.55153203342616 04:26:57 INFO - PROCESS | 12799 | |3;Decrypt;5122.448979591837 04:26:57 INFO - PROCESS | 12799 | |4;RayTrace;2022.2222222222222 04:26:57 INFO - PROCESS | 12799 | |5;Earley;785.5459544383347 04:26:57 INFO - PROCESS | 12799 | |6;Boyer;12481.481481481482 04:26:57 INFO - PROCESS | 12799 | |7;RegExp;27243.243243243243 04:26:57 INFO - PROCESS | 12799 | |8;Splay;618.8118811881188 04:26:57 INFO - PROCESS | 12799 | |9;NavierStokes;4840.579710144928 04:26:57 INFO - PROCESS | 12799 | __end_tp_report 04:26:57 INFO - PROCESS | 12799 | __startTimestamp1450787217422__endTimestamp 04:26:57 INFO - PROCESS | 12799 | 04:26:57 INFO - PROCESS | 12799 | ------- Summary: start ------- 04:26:57 INFO - PROCESS | 12799 | Number of tests: 10 04:26:57 INFO - PROCESS | 12799 | 04:26:57 INFO - PROCESS | 12799 | [#0] Richards Cycles:1 Average:170.24 Median:170.24 stddev:0.00 (0.0%) 04:26:57 INFO - PROCESS | 12799 | Values: 170.2 04:26:57 INFO - PROCESS | 12799 | 04:26:57 INFO - PROCESS | 12799 | [#1] DeltaBlue Cycles:1 Average:187.72 Median:187.72 stddev:0.00 (0.0%) 04:26:57 INFO - PROCESS | 12799 | Values: 187.7 04:26:57 INFO - PROCESS | 12799 | 04:26:57 INFO - PROCESS | 12799 | [#2] Encrypt Cycles:1 Average:278.55 Median:278.55 stddev:0.00 (0.0%) 04:26:57 INFO - PROCESS | 12799 | Values: 278.6 04:26:57 INFO - PROCESS | 12799 | 04:26:57 INFO - PROCESS | 12799 | [#3] Decrypt Cycles:1 Average:5122.45 Median:5122.45 stddev:0.00 (0.0%) 04:26:57 INFO - PROCESS | 12799 | Values: 5122.4 04:26:57 INFO - PROCESS | 12799 | 04:26:57 INFO - PROCESS | 12799 | [#4] RayTrace Cycles:1 Average:2022.22 Median:2022.22 stddev:0.00 (0.0%) 04:26:57 INFO - PROCESS | 12799 | Values: 2022.2 04:26:57 INFO - PROCESS | 12799 | 04:26:57 INFO - PROCESS | 12799 | [#5] Earley Cycles:1 Average:785.55 Median:785.55 stddev:0.00 (0.0%) 04:26:57 INFO - PROCESS | 12799 | Values: 785.5 04:26:57 INFO - PROCESS | 12799 | 04:26:57 INFO - PROCESS | 12799 | [#6] Boyer Cycles:1 Average:12481.48 Median:12481.48 stddev:0.00 (0.0%) 04:26:57 INFO - PROCESS | 12799 | Values: 12481.5 04:26:57 INFO - PROCESS | 12799 | 04:26:57 INFO - PROCESS | 12799 | [#7] RegExp Cycles:1 Average:27243.24 Median:27243.24 stddev:0.00 (0.0%) 04:26:57 INFO - PROCESS | 12799 | Values: 27243.2 04:26:57 INFO - PROCESS | 12799 | 04:26:57 INFO - PROCESS | 12799 | [#8] Splay Cycles:1 Average:618.81 Median:618.81 stddev:0.00 (0.0%) 04:26:57 INFO - PROCESS | 12799 | Values: 618.8 04:26:57 INFO - PROCESS | 12799 | 04:26:57 INFO - PROCESS | 12799 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 04:26:57 INFO - PROCESS | 12799 | Values: 4840.6 04:26:57 INFO - PROCESS | 12799 | -------- Summary: end -------- 04:26:57 INFO - PROCESS | 12799 | 04:26:58 INFO - TEST-INFO | 12799: exit 0 04:26:58 INFO - TEST-OK | v8_7 | took 40738ms 04:26:58 INFO - SUITE-END | took 1219s 04:26:58 INFO - Completed test suite (00:20:19) 04:26:58 INFO - Working with test: dromaeo_css 04:26:58 INFO - Generating results file: dromaeo_css 04:26:58 INFO - Working with test: kraken 04:26:58 INFO - Generating results file: kraken 04:26:58 INFO - javascript benchmark 04:26:58 INFO - Working with test: v8_7 04:26:58 INFO - Generating results file: v8_7 04:26:58 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:26:58 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,94,35]] 04:26:58 INFO - process_Request line: dromaeo_css 6324.09 graph.html#tests=[[72,94,35]] 04:26:58 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:26:58 INFO - process_Request line: kraken 1520.90 graph.html#tests=[[232,94,35]] 04:26:58 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:26:58 INFO - process_Request line: v8_7 19618.15 graph.html#tests=[[230,94,35]] 04:26:58 INFO - RETURN: dromaeo_css: 6324.09 04:26:58 INFO - RETURN: kraken: 1520.90 04:26:58 INFO - RETURN: v8_7: 19618.15 04:26:58 INFO - javascript benchmark 04:26:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2578.12343803107, 2656.5882288245302, 2663.214351766229, 2679.517686816372, 2681.8524981126043, 4417.1607394595, 4521.773911304438, 4544.431946006749, 4581.656375771818, 4590.609798167152, 4553.203189441851, 4595.7242565446095, 4618.745968971705, 4632.49042605314, 4652.930206046904, 4100.0, 4138.193052354792, 4300.741955482681, 4361.236783562864, 4373.387725718402, 4108.979455102721, 4198.538160802294, 4310.374995625632, 4332.566743325674, 4369.847055353063, 4135.545090040093, 4172.561881002512, 4202.0, 4224.049588842517, 4248.192843359782, 4238.512571054337, 4263.189993901149, 4265.552117027699, 4305.956940430587, 4312.202242585132, 4101.036256479725, 4219.641330486882, 4260.126674031816, 4260.510041345254, 4313.892152696177, 4387.188370151533, 4491.708038977456, 4499.797509112098, 4519.050999290153, 4539.387182730322, 4915.066137433876, 4920.926186107211, 4923.113839508887, 4923.48303428142, 4976.950230497721, 4698.483166851644, 4945.505449455061, 4945.703257804544, 4958.206686930074, 4994.051130285234, 4484.506704262529, 4486.730796152241, 4502.887427814266, 4586.128635559233, 4644.744539050384, 5031.874203144877, 5048.091343558195, 5048.72232027242, 5051.6716413433005, 5101.846944591668, 4696.084263568571, 4842.0, 4847.854564363075, 4848.0, 4890.584300334512, 4805.495422980606, 4855.927161092586, 4858.05267972749, 4861.052094841542, 4917.950820491821, 4866.245731911488, 4870.853874383774, 4872.853814385574, 4875.926861097087, 4911.926321105187, 4686.27362758773, 4841.491643377465, 4845.345878306454, 4849.612031037508, 4898.338724272177, 3991.7604943703473, 4036.4752582164133, 4052.230076285496, 4052.2908491014546, 4076.5108187017154, 3589.4615807629066, 3607.549056367954, 3615.132368231658, 3647.963520364762, 3661.3775658137647, 4276.978615106967, 4287.142571485715, 4287.249731297011, 4297.3768803523935, 4330.0, 4727.220008698595, 4804.447488538793, 4831.589314908272, 4834.444038935568, 4917.754112294371, 4267.3598960155605, 4274.722143060691, 4277.850275240414, 4292.077203401283, 4327.02641905575, 4396.164728701537, 4401.977990110029, 4408.4930233023615, 4409.4267745193565, 4450.732956022649, 4563.863084107482, 4572.039871626996, 4682.0, 4684.344191813217, 4772.76136193189, 4935.62982776286, 4945.579625731709, 4957.231629097496, 4959.181735013683, 4965.726885021359, 4708.623310135249, 4708.693934894221, 4713.0, 4744.92882606768, 4750.0, 4654.720716757005, 4745.738984355756, 4770.761461926959, 4772.331873537777, 4898.436679781871, 4928.0390323886495, 4935.777889995031, 4949.133901567283, 4955.331030311006, 4957.206846904478, 4811.109944660249, 4813.927791083067, 4817.349657796152, 4845.6608037437045, 4855.927161092657, 4637.350770892145, 4755.239161734106, 4761.880952976203, 4770.356001939694, 4808.7595620219545, 4691.08523837862, 4703.788329525111, 4706.435227772689, 4734.218853889208, 4747.074320507468, 4819.325294458708, 4822.324874517641, 4823.903521929472, 4830.009847981226, 4863.294822250825, 4457.598816106566, 4510.977445112885, 4567.06375193078, 4580.358749774968, 4755.690880092783], "unit": "score", "name": "dojo.html", "value": 4503.998203402108}, {"lowerIsBetter": false, "replicates": [516.0942545832065, 524.5436470270864, 525.8685328667833, 528.4979269693791, 535.5126834580533, 26421.867890660546, 36332.273354532896, 37083.81458092709, 37109.62890371095, 37121.0, 40638.0, 41148.38277425841, 41259.381109283386, 41287.79356103215, 41389.17221655573, 6878.277780833016, 6989.370956613904, 7819.804504887381, 7994.400419968497, 7994.680212791482, 9966.750831229205, 10313.690589282334, 10320.741981450448, 10323.535440905178, 10324.638637647684, 9975.052370024872, 10030.297879148462, 10078.84881726771, 10081.042300981431, 10094.798104037915, 7051.118610173703, 7185.856282874313, 7191.676374563157, 7203.675834587456, 10061.849072263922, 7009.264027277113, 10141.2394070445, 10319.690409287734, 10457.686269411854, 10471.371717696886, 37068.0, 37517.0, 37525.437118443246, 37542.0, 37563.62436375656, 2817.1548535439492, 2847.2312475631466, 2873.396586716792, 2927.399883023975, 3351.8826841060445, 28995.855020724972, 29398.027636882747, 29416.70583294161, 29543.852280738673, 29876.70123298761, 3320.269540701042, 3331.433656278414, 3364.4953257011643, 3381.7970921744773, 3472.322897035079, 213196.0, 214996.0, 215119.0, 215482.0, 215899.99999999843, 50823.23765143526, 52495.73752131215, 52617.0, 53769.462305376444, 56060.0, 49222.0, 49226.50773492291, 49444.505554944706, 49472.25791613129, 49520.75239623779, 13635.113717608323, 13815.516456923959, 13823.447062117604, 13854.86145138556, 13878.930605346908, 9646.951765241269, 9741.853872191923, 9746.75633109178, 9756.0, 9785.168260697921, 18987.0, 19303.710444343345, 19308.4207473776, 19329.226830926604, 19362.80637193638, 7171.462140339496, 7414.777556673308, 7436.1820199777985, 7446.66490007951, 7448.553086814808, 810.0441479054772, 812.3988248695922, 839.8908141941508, 916.0, 941.9952900235455, 26142.0, 27019.864900675762, 27404.58893116565, 27582.0, 27678.861605692244, 913.0139449394638, 932.3659911260409, 939.3800091939287, 939.8872135343803, 940.041158018817, 13296.867031329757, 13603.31983400826, 13965.301734913417, 14665.120092794466, 14889.329980150702, 254452.0, 256182.0, 257977.0, 259497.0, 261491.0, 46002.53997460049, 46227.0, 46271.30593041107, 46284.7685761569, 46349.0, 1173.049829637979, 1186.2882270637722, 1192.6243233381458, 1204.6265657646159, 1213.969650758738, 26571.60142597824, 27224.319392015357, 27354.863225683745, 27853.16440506788, 27863.860680696467, 40476.39285410662, 40642.390364145154, 40647.796761016005, 40858.591414086666, 40920.0, 239570.0, 242246.0, 242535.0, 315075.0, 322720.0, 26402.471950561267, 26474.602880956416, 26482.470350592495, 26504.469910602067, 26897.731022689524, 35942.640573593926, 35985.46021809727, 36658.0, 37095.0, 39922.600773991886, 33353.0, 33648.18058762637, 34006.3198736019, 34484.310313794085, 34784.0, 33976.32047359089, 34114.31771364609, 34453.82773086119, 34516.82741586276, 34573.827130864185, 33350.33299334048, 34519.30961380708, 34699.82650086733, 34765.13087172841, 34794.478082828275, 28794.28014299659, 30995.0701478956, 31238.687613124486, 31368.686313136575, 31419.84290078535, 24143.758562414852, 24175.0, 24223.878880605484, 24486.510269794147, 25463.74536254614], "unit": "score", "name": "ext.html", "value": 17025.10683049266}, {"lowerIsBetter": false, "replicates": [288.2045554270214, 299.48339115026585, 303.617442023051, 308.714439143792, 310.1563746609222, 12477.875221247785, 12793.0, 14669.486567970123, 15082.999999999985, 15234.390624375026, 14990.175540345277, 15380.230988450561, 15767.211639418012, 15842.683146337067, 15889.682206355867, 4861.392325959264, 4902.2156454967035, 4991.101601711691, 4999.825006124786, 5005.749712514378, 3660.1764602964386, 3790.5261842269715, 3795.3737633290475, 5052.823151189709, 5481.205225242337, 5571.665700057989, 5586.050371436845, 5603.187537807036, 5630.09918413054, 5632.986062508747, 5486.972565137189, 5652.0, 5662.745176467069, 5664.376918538957, 5667.093265077568, 4934.827281045146, 4936.062148191832, 4936.358273424467, 4950.554450099508, 4953.0836795192645, 19104.522386940298, 19986.300479483147, 20069.39791806248, 21127.0, 22097.116115355526, 1829.0763164601924, 1886.981130188708, 1927.8457723382096, 1976.5849171673965, 1980.9504762381055, 13880.93059534706, 13883.861161388359, 13887.0, 14042.4553299137, 14466.49367272151, 1942.9028548572514, 2023.4435530229157, 2032.8334915530538, 2057.7324947756697, 2122.649762789138, 60282.09576856351, 62125.37874621286, 62538.68730656317, 62841.68579157121, 63951.36048639547, 15639.921800390925, 15698.136602486744, 15716.764248536281, 15721.606959826096, 15780.68438631244, 22877.88561057184, 22953.0, 23145.768542314698, 23184.65223021656, 23222.65166022511, 8217.79455513617, 8312.501249925024, 8327.125651806595, 8346.457480263764, 8424.620892059873, 6654.26803051664, 6664.766733164316, 6679.966600166968, 6711.865762684719, 6746.662666866637, 7715.498492597963, 7732.845343093107, 7739.303462688273, 7742.109657389472, 7778.377729781604, 1688.21498003429, 1690.129583264595, 1694.669539439822, 1700.9319627214772, 2131.997960958347, 863.8272345530793, 886.8093359927647, 934.5327336331834, 943.3019565521602, 970.5438443931341, 14962.850371496146, 15707.842921570867, 16038.14520915524, 16094.75857862133, 16118.274677639534, 811.7889348769245, 813.2883726739103, 815.7919730468692, 825.2160447574828, 834.8079941613463, 8628.137186281447, 9035.774105647411, 9134.269258459308, 9164.633414663473, 9267.304952128618, 408426.0, 412047.0, 415846.0, 441391.0, 451472.0, 71668.0, 71717.6414117926, 75176.62411688016, 75624.0, 75673.0, 1010.8938561451089, 1037.7180153021159, 1065.760203954104, 1067.8878717734526, 1073.4096247064083, 14394.136351818925, 14462.339839539822, 14524.572037633658, 14600.196989165697, 14936.925315373353, 33041.0, 33099.17252068718, 33910.0, 34047.65952340445, 34536.0, 43597.56402435935, 44001.77999109984, 44373.33439998467, 45143.7742811297, 47461.7626911877, 8552.529610871461, 8605.182507661762, 8805.779855503664, 8813.42712723671, 8822.735317940473, 10496.317739346918, 10501.474926253504, 10545.57817687284, 13758.587242382744, 16408.425705100264, 13395.665108372368, 13660.590182294547, 13920.860791392362, 13956.0, 13984.160950343012, 12953.287569183409, 13252.0, 13417.792398684165, 13510.527131550349, 13719.314034298046, 13292.335383230606, 13544.932275338955, 13620.591382258548, 13810.930945345612, 14122.293885305899, 8631.956840215758, 8709.216170544682, 8727.389082764146, 8777.210051095177, 8777.253933415732, 13187.53843615469, 13429.127106738031, 13676.31618419095, 13880.583582492542, 13955.511557095453], "unit": "score", "name": "jquery.html", "value": 8824.567792991797}, {"lowerIsBetter": false, "replicates": [1433.0470237292202, 1462.1884853906085, 1476.5348915091745, 1584.738518144506, 1666.366780623363, 6065.666388348639, 6821.147356580427, 7077.150741910978, 7157.391621712148, 7159.713611455535, 6861.382475577197, 6996.685149168287, 7000.544964577299, 7001.2998700129965, 7011.368976792088, 1669.6410271791563, 1715.4510556621885, 1989.0850208903921, 2006.9096890639883, 2021.5855749571303, 2037.7554693436734, 2043.3563427520282, 2045.0592727345438, 2045.6215600114026, 2047.3141497598322, 1947.4449781812186, 1980.2870966452065, 1983.702444633302, 1984.9603007939832, 1986.4437957371958, 2004.7193392924855, 2019.5153163240716, 2021.3834780391974, 2052.5792212596457, 2052.733144691188, 2049.4876280929766, 2065.0707181768266, 2065.297798748433, 2066.700328452366, 2066.927657531994, 7108.431325494, 7167.569945803269, 7193.3166349196745, 7202.387797037206, 7202.927970720278, 4112.670986321117, 4202.894927626803, 4209.957900420987, 4212.599803018708, 4212.7472351659, 2502.4744803591266, 2595.5587550116525, 2600.7659310661943, 2602.6746656667915, 2628.4743051389605, 770.4645271536284, 772.8995230619984, 785.1206648553599, 785.8506883692137, 798.4131663227581, 9712.0, 9737.464439455827, 9763.218942484584, 9772.755681107958, 9777.90222097777, 3727.347714150013, 3785.9242815143543, 3805.809709514513, 3806.8286927088348, 3862.0, 8332.50004999702, 8365.874511882326, 8391.16088391156, 8394.496330220085, 8405.411621186458, 4198.412222288882, 4209.368594710818, 4214.831406743757, 4216.0, 4216.936745948813, 3841.2125514269505, 3841.8079096045085, 3844.3272427325105, 3848.3265428550453, 3852.460655508231, 2971.4948458762065, 3007.1129016940054, 3014.351914338428, 3058.0, 3321.219513414394, 1036.5024788101603, 1054.7995880782628, 1059.2849826367171, 1062.1874266186373, 1074.2211896375065, 856.952867592276, 868.6221493650282, 886.7650072730731, 888.6534251641865, 891.9152680495342, 6641.767538136142, 6767.526273160832, 6780.050792888999, 6792.864142717118, 6808.148981377328, 1012.7569383348091, 1036.730450082984, 1042.588177669816, 1049.8267785815408, 1050.9208020499857, 4881.365422495053, 4910.0, 4910.754462276872, 4921.040397122527, 4923.75381230937, 8520.318374530023, 8539.957300213458, 8717.825643487095, 8727.647214681734, 8752.56237188138, 8533.146685331418, 8540.975082989957, 8557.315414766803, 8618.439801412887, 8636.093210212963, 6808.08090907731, 6818.215905170969, 6885.690143943534, 6939.201991771011, 6946.6179360134665, 6482.254540727877, 6522.902156467751, 6524.641144737085, 6531.836704082436, 6552.770653027121, 7698.07623085211, 7827.0, 7902.604869756604, 7928.365730741411, 8011.799705007422, 7724.92275077242, 7794.415418843496, 7873.330766884879, 8085.797855053671, 8183.140770219041, 6379.362063793584, 6474.773382931575, 6476.31998640136, 6479.222493300834, 6485.448736857231, 6861.382475577222, 6896.103506544117, 6924.896126558005, 6987.02181694553, 7008.439324854102, 6310.6844657766005, 6332.683365831782, 6337.081123237012, 6352.36476352361, 6486.578372405778, 6213.751449942132, 6327.462165715781, 6400.039994000751, 6495.350464953656, 6566.967165164144, 6563.343665633399, 6580.80257592273, 6633.834154146185, 6659.2008958925235, 6666.733330666719, 6087.147799308189, 6118.847028824315, 6119.051547010221, 6133.3866613338305, 6140.1710769047395, 5903.49820265265, 6026.517878569616, 6031.09533569968, 6145.231846019247, 6201.658908760061], "unit": "score", "name": "mootools.html", "value": 4036.076698016822}, {"lowerIsBetter": false, "replicates": [270.9525832979229, 276.17423902531436, 277.88884446221516, 286.0545895814334, 287.22449386656035, 5043.420006699231, 5307.20391941209, 5365.543928766055, 5383.784648614051, 5391.919121213185, 5221.39953905301, 5309.8938021239555, 5310.6017048721305, 5325.600579956509, 5340.412554618989, 4100.938485922706, 4115.238680844039, 4123.3196522573735, 4123.731957422773, 4129.112240868213, 4115.444415003981, 4119.938200926988, 4121.093359460914, 4124.340105583107, 4124.917501649965, 4079.2453396121664, 4082.448869402622, 4085.1829634073156, 4088.89777755557, 4090.0, 3976.4234186043004, 4064.288749468831, 4064.5325787534516, 4068.4914385701786, 4073.4500842386196, 3528.0121565961317, 3529.8764543240864, 3530.470429435605, 3537.3809583322814, 3542.1144713821545, 5119.180931051052, 5123.820666276662, 5123.974380128113, 5130.230465430215, 5137.743112844343, 4655.534446555352, 4658.068386322749, 4659.767011649438, 4662.487126416091, 4665.510121437234, 5282.577393808525, 5438.510534051954, 5501.092319767234, 5600.6079574429805, 5609.775608975636, 3712.4988126602834, 3718.4050551911564, 3719.20037192005, 3720.6465385788306, 3721.702263818888, 5536.114221724545, 5742.856428589319, 5745.454181852759, 5833.883322333572, 5839.065749480105, 3759.962400376016, 3822.063594419385, 3906.90232744178, 3914.706397020235, 3921.137349783043, 3938.6455219030427, 3960.089179488676, 3965.722399432012, 3967.6429121379215, 3970.4242884781543, 4358.956410435919, 4455.131249406335, 4515.706479078849, 4573.519780423074, 4597.448306203277, 5556.722163891789, 5573.749181286852, 5582.972085139549, 5585.69278689676, 5586.050371436784, 1391.1374947532595, 1417.6314158318705, 1419.0917812599944, 1420.4460260498413, 1422.0472283570032, 919.5264438814016, 920.7375897869075, 939.1594522901964, 940.5955439161089, 950.1068995144542, 4917.409910810726, 4923.581495572845, 4927.211646136672, 4933.3586633738105, 4936.259561065869, 5785.652860828363, 5785.971070144622, 5788.131780232915, 5791.218185544897, 5791.391903850119, 4910.533499317559, 4914.606831453475, 4915.311856340115, 4918.286848406961, 4923.77842997066, 3015.8492075396143, 3074.969250307513, 3106.5340198970334, 3112.3308488675043, 3115.6417012043903, 5521.917171242435, 5545.140503222007, 5557.499825015768, 5557.722113894289, 5558.360788509292, 5959.645939853734, 5989.610675306091, 5992.790252341147, 5999.940000600025, 6048.576599637983, 5536.667799931856, 5538.667679939216, 5541.418151094158, 5542.8337149885565, 5544.91682624761, 5669.7165141741925, 5778.451047150514, 5822.854428639149, 5824.155497452761, 5831.446012628793, 5698.375962850568, 5703.828885133453, 5708.115242137475, 5708.229389032594, 5709.343425505954, 5532.861678458071, 5536.91694624589, 5537.280153580009, 5538.418466061005, 5538.529225015757, 3744.382176940774, 3802.8478860845257, 3825.1393436477683, 3838.7120965928225, 3838.9616103838603, 5598.1322894951345, 5740.598158129058, 5747.051736463437, 5778.248827652378, 5781.4218578141845, 5449.100898351728, 5592.636478628876, 5619.201855406231, 5627.5497960162265, 5634.154876768517, 5592.245046918614, 5592.580556458201, 5597.496225339576, 5598.692071936082, 5602.215689803512, 5369.248305237192, 5487.847552013962, 5493.945060549343, 5495.093309603871, 5496.80761173357, 5592.972035139798, 5623.915641265303, 5635.633683810539, 5647.7176141193595, 5650.378458369494, 5445.618806683494, 5455.1544510600925, 5480.479354461319, 5500.147477141049, 5523.944760552343], "unit": "score", "name": "prototype.html", "value": 4155.487178668509}, {"lowerIsBetter": false, "replicates": [650.5153660522908, 711.2745000099899, 711.8608581213452, 773.400614523744, 774.2953911940135, 10878.184136189788, 11064.0, 11107.166962477826, 11125.888741112587, 11148.721281967944, 11057.0, 11353.545858165664, 11371.943140284287, 11409.37248451335, 12389.938050309758, 798.660569258066, 812.8008637883727, 813.9674413023472, 814.250889181954, 814.6293436486385, 801.9238172373615, 809.7489778168787, 809.8623234050226, 809.9028116626013, 810.9229623185788, 841.9073901870789, 850.8340873529664, 850.8808766772656, 851.1573542193246, 852.2542775071812, 842.473454091193, 842.9030661473917, 843.7342237195326, 845.0788640381983, 849.1084361420484, 633.7084940927133, 635.0220660183312, 635.034747184282, 635.4725577770439, 635.4852569418786, 11687.649370518899, 11785.410729463492, 11803.0, 11808.0, 11817.645470635809, 11163.553457861675, 11494.42527873603, 11585.131115166312, 11709.590164344292, 11836.822447663291, 9056.230220431271, 9131.086891310882, 9211.723648290563, 9241.584128714157, 9291.72124836256, 3234.4663130583426, 3298.4887342461716, 3336.432806422914, 3338.5159151923076, 3405.080628230389, 34035.82982085099, 34694.65305346965, 37407.0, 37879.62120378816, 38155.23689526222, 9081.500517471603, 9183.494907780003, 9197.402168859002, 9268.304877134242, 9538.046195380546, 14544.709105818036, 14955.327010284564, 14993.475228366955, 15006.0, 15025.774613380809, 6381.4575761059905, 6387.616742995435, 6465.321141280192, 6558.409743123142, 6629.11070344959, 3599.7300202484917, 3644.726645501598, 3658.981705091511, 3689.3728066228805, 3721.4789929409903, 2438.6585877977095, 2445.5597992361545, 2450.571150048734, 2457.9062317268645, 2461.040194324215, 471.6156332588929, 472.43072098121684, 480.2556038140937, 481.4992407895749, 488.64573184440997, 520.2794130129797, 590.5983930927011, 599.95800293979, 604.268834709997, 612.4824523277823, 7028.1917579477995, 7226.819329516804, 7301.08736407949, 7325.084364454443, 7416.110066792019, 439.7559354558187, 555.9583031272671, 585.7416581452815, 614.9385061493815, 621.8942779727457, 3440.6559344065395, 3572.98213508936, 3577.463380492895, 3960.881173564798, 4073.0, 42678.35982460265, 42883.57116428858, 43005.78497107494, 43040.13919721588, 43077.56922430798, 41701.0, 41794.79102604467, 42133.78933105315, 42497.0, 42543.57456425396, 32546.0, 33480.83259583735, 34529.30941381209, 35901.8204908979, 40106.39840402397, 7682.539047657158, 7824.608769561613, 7833.804154895945, 8000.6399712011935, 8058.798530036796, 30338.393232135677, 30742.385152297276, 30800.69199308068, 32325.838370807996, 33123.171920701214, 37470.250594988494, 37852.621473786014, 37861.81069094637, 38981.6101838978, 41780.0, 10686.89313106859, 10835.133189344991, 10931.18016148776, 10957.780844382909, 11246.357106080228, 10763.94618026905, 10867.456627168453, 10943.01512863846, 11007.83488247693, 11156.330620162817, 10492.422916739653, 10602.363858168535, 10693.144548436261, 10945.83581246266, 11311.830322545004, 10488.0, 10839.187060970617, 11044.613438529614, 11050.33697978124, 11280.661580152608, 9883.703488895344, 10108.090271875566, 10339.172866170838, 10419.218558608287, 10484.108850747467, 8837.293016558788, 9063.456192628464, 9335.626574936927, 9351.812963740824, 9528.380655257386, 8822.161894620001, 8919.464832110094, 9277.721668349961, 9281.62873485053, 9292.72121836346], "unit": "score", "name": "yui.html", "value": 5636.035907663274}], "name": "dromaeo_css", "value": 6324.081798947424}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 115.0, 107.0, 113.0, 113.0, 112.0, 102.0, 113.0, 111.0, 104.0], "unit": "score", "name": "ai-astar", "value": 110.1}, {"lowerIsBetter": true, "replicates": [157.0, 129.0, 159.0, 164.0, 136.0, 158.0, 154.0, 130.0, 165.0, 133.0], "unit": "score", "name": "audio-beat-detection", "value": 148.5}, {"lowerIsBetter": true, "replicates": [163.0, 161.0, 161.0, 160.0, 162.0, 161.0, 163.0, 163.0, 164.0, 173.0], "unit": "score", "name": "audio-dft", "value": 163.1}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 80.0, 90.0, 71.0, 74.0, 72.0, 101.0, 92.0, 71.0], "unit": "score", "name": "audio-fft", "value": 79.4}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 130.0, 96.0, 95.0, 94.0, 134.0, 95.0, 94.0, 133.0], "unit": "score", "name": "audio-oscillator", "value": 106.1}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 109.0, 110.0, 110.0, 110.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 148.0, 147.0, 148.0, 147.0, 147.0, 146.0, 149.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 147.1}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 94.9}, {"lowerIsBetter": true, "replicates": [71.0, 75.0, 71.0, 71.0, 71.0, 70.0, 71.0, 79.0, 69.0, 69.0], "unit": "score", "name": "json-parse-financial", "value": 71.7}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 67.0, 67.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.8}, {"lowerIsBetter": true, "replicates": [82.0, 84.0, 83.0, 83.0, 83.0, 83.0, 83.0, 90.0, 91.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.5}, {"lowerIsBetter": true, "replicates": [130.0, 127.0, 125.0, 123.0, 123.0, 123.0, 124.0, 128.0, 124.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.6}, {"lowerIsBetter": true, "replicates": [137.0, 147.0, 147.0, 150.0, 149.0, 138.0, 149.0, 136.0, 149.0, 135.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.7}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 69.0, 72.0, 71.0, 69.0, 68.0, 70.0, 71.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.0}], "name": "kraken", "value": 1520.8999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [170.24174327545114], "unit": "score", "name": "Richards", "value": 207.36394799999997}, {"lowerIsBetter": false, "replicates": [187.72292096865027], "unit": "score", "name": "DeltaBlue", "value": 352.210586}, {"lowerIsBetter": false, "replicates": [278.55153203342616], "unit": "score", "name": "Encrypt", "value": 955.5897900000004}, {"lowerIsBetter": false, "replicates": [5122.448979591837], "unit": "score", "name": "Decrypt", "value": 51.96362151394425}, {"lowerIsBetter": false, "replicates": [2022.2222222222222], "unit": "score", "name": "RayTrace", "value": 365.9286263736265}, {"lowerIsBetter": false, "replicates": [785.5459544383347], "unit": "score", "name": "Earley", "value": 848.4073989999999}, {"lowerIsBetter": false, "replicates": [12481.481481481482], "unit": "score", "name": "Boyer", "value": 53.39614540059344}, {"lowerIsBetter": false, "replicates": [27243.243243243243], "unit": "score", "name": "RegExp", "value": 33.43893353174606}, {"lowerIsBetter": false, "replicates": [618.8118811881188], "unit": "score", "name": "Splay", "value": 131.68945600000004}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 19618.153327025513}]} 04:26:58 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,35]]", "result": "19618.15"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,35]]", "result": "1520.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,35]]", "result": "6324.09"}}} 04:26:58 INFO - Return code: 0 04:26:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:26:58 INFO - # TBPL SUCCESS # 04:26:58 INFO - Running post-action listener: _resource_record_post_action 04:26:58 INFO - Running post-run listener: _resource_record_post_run 04:26:59 INFO - Total resource usage - Wall time: 1236s; CPU: 13.0%; Read bytes: 8192; Write bytes: 546529280; Read time: 748; Write time: 877784 04:26:59 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 4096; Write bytes: 227438592; Read time: 216; Write time: 443616 04:26:59 INFO - run-tests - Wall time: 1221s; CPU: 13.0%; Read bytes: 4096; Write bytes: 318226432; Read time: 532; Write time: 434120 04:26:59 INFO - Running post-run listener: _upload_blobber_files 04:26:59 INFO - Blob upload gear active. 04:26:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:26:59 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 04:26:59 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:26:59 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:27:00 INFO - (blobuploader) - INFO - Open directory for files ... 04:27:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:27:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:27:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:27:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:27:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:27:01 INFO - (blobuploader) - INFO - Done attempting. 04:27:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:27:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:27:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:27:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:27:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:27:02 INFO - (blobuploader) - INFO - Done attempting. 04:27:02 INFO - (blobuploader) - INFO - Iteration through files over. 04:27:02 INFO - Return code: 0 04:27:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:27:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:27:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3c0b72a9b53fd9c681e515a7a420544d45f03606981471bfe07539abe644bdedcce46e63ed9522f252cc6443b7200e44c09cd46c102f1267e181007fc0ec3a39", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3c354c5bb836a0c87608475d51fba9c0de87ad65eed9e8102ae9e0617f591779c8e33760b33c450107abbbb2395110b00668d4370cc2b5a78867e057c0393909"} 04:27:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:27:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:27:02 INFO - Contents: 04:27:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3c0b72a9b53fd9c681e515a7a420544d45f03606981471bfe07539abe644bdedcce46e63ed9522f252cc6443b7200e44c09cd46c102f1267e181007fc0ec3a39", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3c354c5bb836a0c87608475d51fba9c0de87ad65eed9e8102ae9e0617f591779c8e33760b33c450107abbbb2395110b00668d4370cc2b5a78867e057c0393909"} 04:27:02 INFO - Copying logs to upload dir... 04:27:02 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1280.977425 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2015-12-22 04:27:00.622568) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-22 04:27:00.625809) ========= 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=fc81d3768dcd4b6275e033c4000001b5-1450777764.221174-438808712 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3c0b72a9b53fd9c681e515a7a420544d45f03606981471bfe07539abe644bdedcce46e63ed9522f252cc6443b7200e44c09cd46c102f1267e181007fc0ec3a39", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3c354c5bb836a0c87608475d51fba9c0de87ad65eed9e8102ae9e0617f591779c8e33760b33c450107abbbb2395110b00668d4370cc2b5a78867e057c0393909"} build_url:https://queue.taskcluster.net/v1/task/wgwDOn3iRFK19ShtaC4ZNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011356 build_url: 'https://queue.taskcluster.net/v1/task/wgwDOn3iRFK19ShtaC4ZNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3c0b72a9b53fd9c681e515a7a420544d45f03606981471bfe07539abe644bdedcce46e63ed9522f252cc6443b7200e44c09cd46c102f1267e181007fc0ec3a39", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3c354c5bb836a0c87608475d51fba9c0de87ad65eed9e8102ae9e0617f591779c8e33760b33c450107abbbb2395110b00668d4370cc2b5a78867e057c0393909"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-22 04:27:00.650158) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 04:27:00.650491) ========= 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=fc81d3768dcd4b6275e033c4000001b5-1450777764.221174-438808712 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004443 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 04:27:00.735033) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-22 04:27:00.735343) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-22 04:27:00.735619) ========= ========= Total master_lag: 0.25 =========