builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-050 starttime: 1452621444.84 results: success (0) buildid: 20160112085155 builduid: be5d13da2fe246f1a595e45d224d57ed revision: 80d8340b39c19817224c09b31bfa412d96b29317 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-12 09:57:24.836738) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-12 09:57:24.837179) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-12 09:57:24.837478) ========= 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=6dbc10da6d83fee962c624be000001a8-1452620691.459913-160078361 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006303 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-12 09:57:24.863164) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-12 09:57:24.863445) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-12 09:57:24.879204) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 09:57:24.879469) ========= 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=6dbc10da6d83fee962c624be000001a8-1452620691.459913-160078361 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004579 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 09:57:24.930747) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-12 09:57:24.931002) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-12 09:57:24.931358) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 09:57:24.931628) ========= 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=6dbc10da6d83fee962c624be000001a8-1452620691.459913-160078361 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-12 09:57:24-- 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% 37.8M=0s 2016-01-12 09:57:25 (37.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.104905 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 09:57:25.048678) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 09:57:25.048970) ========= 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=6dbc10da6d83fee962c624be000001a8-1452620691.459913-160078361 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021578 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 09:57:25.099547) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-12 09:57:25.099865) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 80d8340b39c19817224c09b31bfa412d96b29317 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 80d8340b39c19817224c09b31bfa412d96b29317 --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=6dbc10da6d83fee962c624be000001a8-1452620691.459913-160078361 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-12 09:57:25,215 truncating revision to first 12 chars 2016-01-12 09:57:25,215 Setting DEBUG logging. 2016-01-12 09:57:25,215 attempt 1/10 2016-01-12 09:57:25,215 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/80d8340b39c1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-12 09:57:26,339 unpacking tar archive at: fx-team-80d8340b39c1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.427193 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-12 09:57:26.539879) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-12 09:57:26.540170) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-12 09:57:26.548042) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-12 09:57:26.548326) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-12 09:57:26.548712) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 55 secs) (at 2016-01-12 09:57:26.548994) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6dbc10da6d83fee962c624be000001a8-1452620691.459913-160078361 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:57:26 INFO - MultiFileLogger online at 20160112 09:57:26 in /builds/slave/test 09:57:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 09:57:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:57:26 INFO - {'append_to_log': False, 09:57:26 INFO - 'base_work_dir': '/builds/slave/test', 09:57:26 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:57:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:57:26 INFO - 'branch': 'Fx-Team-Non-PGO', 09:57:26 INFO - 'buildbot_json_path': 'buildprops.json', 09:57:26 INFO - 'config_files': ('talos/linux_config.py',), 09:57:26 INFO - 'default_actions': ('clobber', 09:57:26 INFO - 'read-buildbot-config', 09:57:26 INFO - 'download-and-extract', 09:57:26 INFO - 'populate-webroot', 09:57:26 INFO - 'create-virtualenv', 09:57:26 INFO - 'install', 09:57:26 INFO - 'run-tests'), 09:57:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:57:26 INFO - 'download_minidump_stackwalk': True, 09:57:26 INFO - 'download_symbols': 'ondemand', 09:57:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:57:26 INFO - 'tooltool.py': '/tools/tooltool.py', 09:57:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:57:26 INFO - '/tools/misc-python/virtualenv.py')}, 09:57:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:57:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:57:26 INFO - 'installer_path': 'installer.exe', 09:57:26 INFO - 'log_level': 'info', 09:57:26 INFO - 'log_name': 'talos', 09:57:26 INFO - 'log_to_console': True, 09:57:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:57:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:57:26 INFO - 'opt_config_files': (), 09:57:26 INFO - 'pip_index': False, 09:57:26 INFO - 'sps_profile': False, 09:57:26 INFO - 'sps_profile_interval': 0, 09:57:26 INFO - 'suite': 'dromaeojs-e10s', 09:57:26 INFO - 'system_bits': '32', 09:57:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:57:26 INFO - 'title': 'talos-linux64-ix-050', 09:57:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:57:26 INFO - 'use_talos_json': True, 09:57:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:57:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:57:26 INFO - 'work_dir': 'build'} 09:57:26 INFO - ##### 09:57:26 INFO - ##### Running clobber step. 09:57:26 INFO - ##### 09:57:26 INFO - Running pre-action listener: _resource_record_pre_action 09:57:26 INFO - Running main action method: clobber 09:57:26 INFO - rmtree: /builds/slave/test/build 09:57:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:57:27 INFO - Running post-action listener: _resource_record_post_action 09:57:27 INFO - ##### 09:57:27 INFO - ##### Running read-buildbot-config step. 09:57:27 INFO - ##### 09:57:27 INFO - Running pre-action listener: _resource_record_pre_action 09:57:27 INFO - Running main action method: read_buildbot_config 09:57:27 INFO - Using buildbot properties: 09:57:27 INFO - { 09:57:27 INFO - "project": "", 09:57:27 INFO - "product": "firefox", 09:57:27 INFO - "script_repo_revision": "production", 09:57:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 09:57:27 INFO - "repository": "", 09:57:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 09:57:27 INFO - "buildid": "20160112085155", 09:57:27 INFO - "pgo_build": "False", 09:57:27 INFO - "basedir": "/builds/slave/test", 09:57:27 INFO - "buildnumber": 945, 09:57:27 INFO - "slavename": "talos-linux64-ix-050", 09:57:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:57:27 INFO - "platform": "ubuntu64_hw", 09:57:27 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:57:27 INFO - "branch": "fx-team", 09:57:27 INFO - "repo_path": "integration/fx-team", 09:57:27 INFO - "revision": "80d8340b39c19817224c09b31bfa412d96b29317", 09:57:27 INFO - "stage_platform": "linux64", 09:57:27 INFO - "builduid": "be5d13da2fe246f1a595e45d224d57ed", 09:57:27 INFO - "slavebuilddir": "test" 09:57:27 INFO - } 09:57:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/fsoeQ2wFRF63tLB3ZtkL0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 09:57:27 INFO - Running post-action listener: _resource_record_post_action 09:57:27 INFO - ##### 09:57:27 INFO - ##### Running download-and-extract step. 09:57:27 INFO - ##### 09:57:27 INFO - Running pre-action listener: _resource_record_pre_action 09:57:27 INFO - Running main action method: download_and_extract 09:57:27 INFO - mkdir: /builds/slave/test/build/tests 09:57:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:27 INFO - https://queue.taskcluster.net/v1/task/fsoeQ2wFRF63tLB3ZtkL0Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:57:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fsoeQ2wFRF63tLB3ZtkL0Q/artifacts/public/build/test_packages.json 09:57:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fsoeQ2wFRF63tLB3ZtkL0Q/artifacts/public/build/test_packages.json 09:57:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fsoeQ2wFRF63tLB3ZtkL0Q/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 09:57:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fsoeQ2wFRF63tLB3ZtkL0Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 09:57:31 INFO - Downloaded 1302 bytes. 09:57:31 INFO - Reading from file /builds/slave/test/build/test_packages.json 09:57:31 INFO - Using the following test package requirements: 09:57:31 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 09:57:31 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:57:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:57:31 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:57:31 INFO - u'jsshell-linux-x86_64.zip'], 09:57:31 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:57:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:57:31 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 09:57:31 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:57:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:57:31 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:57:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:57:31 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:57:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:57:31 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 09:57:31 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:57:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:57:31 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:57:31 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')]} 09:57:31 INFO - https://queue.taskcluster.net/v1/task/fsoeQ2wFRF63tLB3ZtkL0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:57:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fsoeQ2wFRF63tLB3ZtkL0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:57:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fsoeQ2wFRF63tLB3ZtkL0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:57:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fsoeQ2wFRF63tLB3ZtkL0Q/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 09:57:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fsoeQ2wFRF63tLB3ZtkL0Q/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 09:57:39 INFO - Downloaded 22758864 bytes. 09:57:39 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 09:57:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:57:39 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 09:57:40 INFO - Return code: 0 09:57:40 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 09:57:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:40 INFO - https://queue.taskcluster.net/v1/task/fsoeQ2wFRF63tLB3ZtkL0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:57:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fsoeQ2wFRF63tLB3ZtkL0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:57:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fsoeQ2wFRF63tLB3ZtkL0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:57:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fsoeQ2wFRF63tLB3ZtkL0Q/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 09:57:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fsoeQ2wFRF63tLB3ZtkL0Q/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 09:57:50 INFO - Downloaded 22758864 bytes. 09:57:50 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 09:57:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:57:50 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 09:57:51 INFO - Return code: 0 09:57:51 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')]} 09:57:51 INFO - https://queue.taskcluster.net/v1/task/fsoeQ2wFRF63tLB3ZtkL0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:57:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fsoeQ2wFRF63tLB3ZtkL0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 09:57:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fsoeQ2wFRF63tLB3ZtkL0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 09:57:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fsoeQ2wFRF63tLB3ZtkL0Q/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 09:57:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fsoeQ2wFRF63tLB3ZtkL0Q/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 09:57:52 INFO - Downloaded 11132285 bytes. 09:57:52 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 09:57:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 09:57:52 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 09:57:52 INFO - Return code: 0 09:57:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:52 INFO - https://queue.taskcluster.net/v1/task/fsoeQ2wFRF63tLB3ZtkL0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:57:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fsoeQ2wFRF63tLB3ZtkL0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 09:57:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fsoeQ2wFRF63tLB3ZtkL0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 09:57:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fsoeQ2wFRF63tLB3ZtkL0Q/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 09:57:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fsoeQ2wFRF63tLB3ZtkL0Q/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 09:58:19 INFO - Downloaded 53858094 bytes. 09:58:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fsoeQ2wFRF63tLB3ZtkL0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 09:58:19 INFO - mkdir: /builds/slave/test/properties 09:58:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:58:19 INFO - Writing to file /builds/slave/test/properties/build_url 09:58:19 INFO - Contents: 09:58:19 INFO - build_url:https://queue.taskcluster.net/v1/task/fsoeQ2wFRF63tLB3ZtkL0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 09:58:19 INFO - Running post-action listener: _resource_record_post_action 09:58:19 INFO - Running post-action listener: set_extra_try_arguments 09:58:19 INFO - ##### 09:58:19 INFO - ##### Running populate-webroot step. 09:58:19 INFO - ##### 09:58:19 INFO - Running pre-action listener: _resource_record_pre_action 09:58:19 INFO - Running main action method: populate_webroot 09:58:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:58:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:58:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:58:19 INFO - '--tppagecycles', 09:58:19 INFO - '7'], 09:58:19 INFO - 'tests': ['tsvgm']}}, 09:58:19 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:58:19 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:58:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:58:19 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:58:19 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:58:19 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:58:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:58:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:19 INFO - 'talos_options': ['--e10s'], 09:58:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:58:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:19 INFO - 'tests': ['damp', 'tps']}, 09:58:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:19 INFO - 'talos_options': ['--e10s'], 09:58:19 INFO - 'tests': ['damp', 'tps']}, 09:58:19 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:58:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:58:19 INFO - 'other': {'tests': ['a11yr', 09:58:19 INFO - 'ts_paint', 09:58:19 INFO - 'tpaint', 09:58:19 INFO - 'sessionrestore', 09:58:19 INFO - 'sessionrestore_no_auto_restore']}, 09:58:19 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:58:19 INFO - 'tests': ['a11yr', 09:58:19 INFO - 'ts_paint', 09:58:19 INFO - 'tpaint', 09:58:19 INFO - 'sessionrestore', 09:58:19 INFO - 'sessionrestore_no_auto_restore']}, 09:58:19 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:58:19 INFO - 'tests': ['a11yr', 09:58:19 INFO - 'ts_paint', 09:58:19 INFO - 'tpaint', 09:58:19 INFO - 'sessionrestore', 09:58:19 INFO - 'sessionrestore_no_auto_restore']}, 09:58:19 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:58:19 INFO - 'tests': ['a11yr', 09:58:19 INFO - 'ts_paint', 09:58:19 INFO - 'tpaint', 09:58:19 INFO - 'sessionrestore', 09:58:19 INFO - 'sessionrestore_no_auto_restore']}, 09:58:19 INFO - 'other_l64': {'tests': ['a11yr', 09:58:19 INFO - 'ts_paint', 09:58:19 INFO - 'tpaint', 09:58:19 INFO - 'sessionrestore', 09:58:19 INFO - 'sessionrestore_no_auto_restore']}, 09:58:19 INFO - 'other_nol64': {'tests': ['a11yr', 09:58:19 INFO - 'ts_paint', 09:58:19 INFO - 'tpaint', 09:58:19 INFO - 'sessionrestore', 09:58:19 INFO - 'sessionrestore_no_auto_restore']}, 09:58:19 INFO - 'svgr': {'tests': ['tsvgx', 09:58:19 INFO - 'tsvgr_opacity', 09:58:19 INFO - 'tart', 09:58:19 INFO - 'tscrollx', 09:58:19 INFO - 'cart']}, 09:58:19 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:58:19 INFO - 'tests': ['tsvgx', 09:58:19 INFO - 'tsvgr_opacity', 09:58:19 INFO - 'tart', 09:58:19 INFO - 'tscrollx', 09:58:19 INFO - 'cart']}, 09:58:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:19 INFO - 'tests': ['tp5o']}, 09:58:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:19 INFO - 'talos_options': ['--e10s'], 09:58:19 INFO - 'tests': ['tp5o']}, 09:58:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:19 INFO - 'talos_options': ['--xperf_path', 09:58:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:58:19 INFO - 'tests': ['tp5n']}, 09:58:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:19 INFO - 'talos_options': ['--e10s', 09:58:19 INFO - '--xperf_path', 09:58:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:58:19 INFO - 'tests': ['tp5n']}}, 09:58:19 INFO - 'talos.zip': {'path': '', 09:58:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:58:19 INFO - Running post-action listener: _resource_record_post_action 09:58:19 INFO - ##### 09:58:19 INFO - ##### Running create-virtualenv step. 09:58:19 INFO - ##### 09:58:19 INFO - Running pre-action listener: _resource_record_pre_action 09:58:19 INFO - Running main action method: create_virtualenv 09:58:19 INFO - Creating virtualenv /builds/slave/test/build/venv 09:58:19 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 09:58:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:58:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:58:20 INFO - Using real prefix '/usr' 09:58:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:58:20 INFO - Installing distribute.............................................................................................................................................................................................done. 09:58:22 INFO - Installing pip.................done. 09:58:22 INFO - Return code: 0 09:58:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:58:22 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')]} 09:58:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:22 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')]} 09:58:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:22 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 0x7fcf5fad1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b5dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13483d0>, '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 0x12b3ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b4360>, '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': '6dbc10da6d83fee962c624be000001a8-1452620691.459913-160078361', '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 09:58:22 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 09:58:22 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 09:58:22 INFO - Using env: {'DISPLAY': ':0', 09:58:22 INFO - 'HOME': '/home/cltbld', 09:58:22 INFO - 'LANG': 'en_US.UTF-8', 09:58:22 INFO - 'LANGUAGE': 'en_US:en', 09:58:22 INFO - 'LOGNAME': 'cltbld', 09:58:22 INFO - 'MAIL': '/var/mail/cltbld', 09:58:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:22 INFO - 'MOZ_NO_REMOTE': '1', 09:58:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:22 INFO - 'NO_EM_RESTART': '1', 09:58:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:22 INFO - 'PWD': '/builds/slave/test', 09:58:22 INFO - 'SHELL': '/bin/bash', 09:58:22 INFO - 'SHLVL': '1', 09:58:22 INFO - 'TERM': 'linux', 09:58:22 INFO - 'TMOUT': '86400', 09:58:22 INFO - 'USER': 'cltbld', 09:58:22 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1452620691.459913-160078361', 09:58:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:22 INFO - '_': '/tools/buildbot/bin/python'} 09:58:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:22 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 09:58:22 INFO - Cleaning up... 09:58:22 INFO - Return code: 0 09:58:22 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:58:22 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')]} 09:58:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:22 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')]} 09:58:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:22 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 0x7fcf5fad1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b5dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13483d0>, '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 0x12b3ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b4360>, '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': '6dbc10da6d83fee962c624be000001a8-1452620691.459913-160078361', '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 09:58:22 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 09:58:22 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 09:58:22 INFO - Using env: {'DISPLAY': ':0', 09:58:22 INFO - 'HOME': '/home/cltbld', 09:58:22 INFO - 'LANG': 'en_US.UTF-8', 09:58:22 INFO - 'LANGUAGE': 'en_US:en', 09:58:22 INFO - 'LOGNAME': 'cltbld', 09:58:22 INFO - 'MAIL': '/var/mail/cltbld', 09:58:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:22 INFO - 'MOZ_NO_REMOTE': '1', 09:58:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:22 INFO - 'NO_EM_RESTART': '1', 09:58:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:22 INFO - 'PWD': '/builds/slave/test', 09:58:22 INFO - 'SHELL': '/bin/bash', 09:58:22 INFO - 'SHLVL': '1', 09:58:22 INFO - 'TERM': 'linux', 09:58:22 INFO - 'TMOUT': '86400', 09:58:22 INFO - 'USER': 'cltbld', 09:58:22 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1452620691.459913-160078361', 09:58:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:22 INFO - '_': '/tools/buildbot/bin/python'} 09:58:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:22 INFO - Downloading/unpacking psutil>=0.7.1 09:58:22 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 09:58:22 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 09:58:22 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 09:58:22 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 09:58:22 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 09:58:22 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 09:58:24 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 09:58:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 09:58:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:58:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:58:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:58:24 INFO - Installing collected packages: psutil 09:58:24 INFO - Running setup.py install for psutil 09:58:24 INFO - building 'psutil._psutil_linux' extension 09:58:24 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 09:58:24 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 09:58:24 INFO - building 'psutil._psutil_posix' extension 09:58:24 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 09:58:25 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 09:58:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:58:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:58:25 INFO - Successfully installed psutil 09:58:25 INFO - Cleaning up... 09:58:25 INFO - Return code: 0 09:58:25 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:58:25 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')]} 09:58:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:25 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')]} 09:58:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:25 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 0x7fcf5fad1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b5dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13483d0>, '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 0x12b3ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b4360>, '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': '6dbc10da6d83fee962c624be000001a8-1452620691.459913-160078361', '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 09:58:25 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 09:58:25 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 09:58:25 INFO - Using env: {'DISPLAY': ':0', 09:58:25 INFO - 'HOME': '/home/cltbld', 09:58:25 INFO - 'LANG': 'en_US.UTF-8', 09:58:25 INFO - 'LANGUAGE': 'en_US:en', 09:58:25 INFO - 'LOGNAME': 'cltbld', 09:58:25 INFO - 'MAIL': '/var/mail/cltbld', 09:58:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:25 INFO - 'MOZ_NO_REMOTE': '1', 09:58:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:25 INFO - 'NO_EM_RESTART': '1', 09:58:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:25 INFO - 'PWD': '/builds/slave/test', 09:58:25 INFO - 'SHELL': '/bin/bash', 09:58:25 INFO - 'SHLVL': '1', 09:58:25 INFO - 'TERM': 'linux', 09:58:25 INFO - 'TMOUT': '86400', 09:58:25 INFO - 'USER': 'cltbld', 09:58:25 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1452620691.459913-160078361', 09:58:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:25 INFO - '_': '/tools/buildbot/bin/python'} 09:58:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:25 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:58:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:27 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:58:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 09:58:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:58:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:58:27 INFO - Installing collected packages: mozsystemmonitor 09:58:27 INFO - Running setup.py install for mozsystemmonitor 09:58:27 INFO - Successfully installed mozsystemmonitor 09:58:27 INFO - Cleaning up... 09:58:27 INFO - Return code: 0 09:58:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:58:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:27 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 0x7fcf5fad1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b5dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13483d0>, '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 0x12b3ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b4360>, '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': '6dbc10da6d83fee962c624be000001a8-1452620691.459913-160078361', '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 09:58:27 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 09:58:27 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 09:58:27 INFO - Using env: {'DISPLAY': ':0', 09:58:27 INFO - 'HOME': '/home/cltbld', 09:58:27 INFO - 'LANG': 'en_US.UTF-8', 09:58:27 INFO - 'LANGUAGE': 'en_US:en', 09:58:27 INFO - 'LOGNAME': 'cltbld', 09:58:27 INFO - 'MAIL': '/var/mail/cltbld', 09:58:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:27 INFO - 'MOZ_NO_REMOTE': '1', 09:58:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:27 INFO - 'NO_EM_RESTART': '1', 09:58:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:27 INFO - 'PWD': '/builds/slave/test', 09:58:27 INFO - 'SHELL': '/bin/bash', 09:58:27 INFO - 'SHLVL': '1', 09:58:27 INFO - 'TERM': 'linux', 09:58:27 INFO - 'TMOUT': '86400', 09:58:27 INFO - 'USER': 'cltbld', 09:58:27 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1452620691.459913-160078361', 09:58:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:27 INFO - '_': '/tools/buildbot/bin/python'} 09:58:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:27 INFO - Downloading/unpacking blobuploader==1.2.4 09:58:27 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 09:58:27 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 09:58:27 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 09:58:27 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 09:58:27 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 09:58:27 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 09:58:29 INFO - Downloading blobuploader-1.2.4.tar.gz 09:58:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 09:58:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:58:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:58:29 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 09:58:29 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 09:58:29 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 09:58:29 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 09:58:29 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 09:58:29 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 09:58:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 09:58:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:58:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:58:29 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 09:58:29 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 09:58:29 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 09:58:29 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 09:58:29 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 09:58:29 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 09:58:29 INFO - Downloading docopt-0.6.1.tar.gz 09:58:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 09:58:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:58:30 INFO - Installing collected packages: blobuploader, requests, docopt 09:58:30 INFO - Running setup.py install for blobuploader 09:58:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:58:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:58:30 INFO - Running setup.py install for requests 09:58:30 INFO - Running setup.py install for docopt 09:58:30 INFO - Successfully installed blobuploader requests docopt 09:58:30 INFO - Cleaning up... 09:58:30 INFO - Return code: 0 09:58:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:58:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:30 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 0x7fcf5fad1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b5dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13483d0>, '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 0x12b3ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b4360>, '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': '6dbc10da6d83fee962c624be000001a8-1452620691.459913-160078361', '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 09:58:30 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 09:58:30 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 09:58:30 INFO - Using env: {'DISPLAY': ':0', 09:58:30 INFO - 'HOME': '/home/cltbld', 09:58:30 INFO - 'LANG': 'en_US.UTF-8', 09:58:30 INFO - 'LANGUAGE': 'en_US:en', 09:58:30 INFO - 'LOGNAME': 'cltbld', 09:58:30 INFO - 'MAIL': '/var/mail/cltbld', 09:58:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:30 INFO - 'MOZ_NO_REMOTE': '1', 09:58:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:30 INFO - 'NO_EM_RESTART': '1', 09:58:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:30 INFO - 'PWD': '/builds/slave/test', 09:58:30 INFO - 'SHELL': '/bin/bash', 09:58:30 INFO - 'SHLVL': '1', 09:58:30 INFO - 'TERM': 'linux', 09:58:30 INFO - 'TMOUT': '86400', 09:58:30 INFO - 'USER': 'cltbld', 09:58:30 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1452620691.459913-160078361', 09:58:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:30 INFO - '_': '/tools/buildbot/bin/python'} 09:58:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:58:30 INFO - Running setup.py (path:/tmp/pip-SsDRzk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:58:30 INFO - Running setup.py (path:/tmp/pip-jE4rkt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:58:30 INFO - Running setup.py (path:/tmp/pip-n6pySe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:58:31 INFO - Running setup.py (path:/tmp/pip-aWhFyQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:58:31 INFO - Running setup.py (path:/tmp/pip-4VR9X9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:58:31 INFO - Running setup.py (path:/tmp/pip-s0xgSr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:58:31 INFO - Running setup.py (path:/tmp/pip-wn9Zkp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:58:31 INFO - Running setup.py (path:/tmp/pip-u3OKqu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:58:31 INFO - Running setup.py (path:/tmp/pip-nWKBpt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:58:31 INFO - Running setup.py (path:/tmp/pip-oDSxV_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:58:31 INFO - Running setup.py (path:/tmp/pip-6JXxwW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:58:31 INFO - Running setup.py (path:/tmp/pip-qcYwoR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:58:31 INFO - Running setup.py (path:/tmp/pip-elmqqV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:58:31 INFO - Running setup.py (path:/tmp/pip-iutOQW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:58:31 INFO - Running setup.py (path:/tmp/pip-FQUFmU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:58:31 INFO - Running setup.py (path:/tmp/pip-QBliXj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:58:31 INFO - Running setup.py (path:/tmp/pip-uONiK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:58:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:58:32 INFO - Running setup.py install for manifestparser 09:58:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:58:32 INFO - Running setup.py install for mozcrash 09:58:32 INFO - Running setup.py install for mozdebug 09:58:32 INFO - Running setup.py install for mozdevice 09:58:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:58:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:58:32 INFO - Running setup.py install for mozfile 09:58:32 INFO - Running setup.py install for mozhttpd 09:58:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:58:32 INFO - Running setup.py install for mozinfo 09:58:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:58:32 INFO - Running setup.py install for mozInstall 09:58:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:58:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:58:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:58:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:58:32 INFO - Running setup.py install for mozleak 09:58:32 INFO - Running setup.py install for mozlog 09:58:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:58:33 INFO - Running setup.py install for moznetwork 09:58:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:58:33 INFO - Running setup.py install for mozprocess 09:58:33 INFO - Running setup.py install for mozprofile 09:58:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:58:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:58:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:58:33 INFO - Running setup.py install for mozrunner 09:58:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:58:33 INFO - Running setup.py install for mozscreenshot 09:58:33 INFO - Running setup.py install for moztest 09:58:33 INFO - Running setup.py install for mozversion 09:58:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:58:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:58:33 INFO - Cleaning up... 09:58:33 INFO - Return code: 0 09:58:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:58:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:33 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 0x7fcf5fad1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b5dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13483d0>, '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 0x12b3ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b4360>, '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': '6dbc10da6d83fee962c624be000001a8-1452620691.459913-160078361', '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 09:58:33 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 09:58:33 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 09:58:33 INFO - Using env: {'DISPLAY': ':0', 09:58:33 INFO - 'HOME': '/home/cltbld', 09:58:33 INFO - 'LANG': 'en_US.UTF-8', 09:58:33 INFO - 'LANGUAGE': 'en_US:en', 09:58:33 INFO - 'LOGNAME': 'cltbld', 09:58:33 INFO - 'MAIL': '/var/mail/cltbld', 09:58:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:33 INFO - 'MOZ_NO_REMOTE': '1', 09:58:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:33 INFO - 'NO_EM_RESTART': '1', 09:58:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:33 INFO - 'PWD': '/builds/slave/test', 09:58:33 INFO - 'SHELL': '/bin/bash', 09:58:33 INFO - 'SHLVL': '1', 09:58:33 INFO - 'TERM': 'linux', 09:58:33 INFO - 'TMOUT': '86400', 09:58:33 INFO - 'USER': 'cltbld', 09:58:33 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1452620691.459913-160078361', 09:58:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:33 INFO - '_': '/tools/buildbot/bin/python'} 09:58:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:58:34 INFO - Running setup.py (path:/tmp/pip-m7DaBh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:58:34 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)) 09:58:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:58:34 INFO - Running setup.py (path:/tmp/pip-F_FVHE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:58:34 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)) 09:58:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:58:34 INFO - Running setup.py (path:/tmp/pip-rUaWHK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:58:34 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)) 09:58:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:58:34 INFO - Running setup.py (path:/tmp/pip-GC8Ko3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:58:34 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)) 09:58:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:58:34 INFO - Running setup.py (path:/tmp/pip-HJ_vEX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:58:34 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)) 09:58:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:58:34 INFO - Running setup.py (path:/tmp/pip-88BV8q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:58:34 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)) 09:58:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:58:34 INFO - Running setup.py (path:/tmp/pip-feYKnf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:58:34 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)) 09:58:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:58:34 INFO - Running setup.py (path:/tmp/pip-5WmhGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:58:34 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)) 09:58:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:58:34 INFO - Running setup.py (path:/tmp/pip-vbIxJd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:58:34 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)) 09:58:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:58:34 INFO - Running setup.py (path:/tmp/pip-m5wR9Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:58:34 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)) 09:58:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:58:34 INFO - Running setup.py (path:/tmp/pip-TWzPDS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:58:34 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)) 09:58:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:58:34 INFO - Running setup.py (path:/tmp/pip-63kvF0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:58:34 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)) 09:58:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:58:34 INFO - Running setup.py (path:/tmp/pip-17npJx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:58:34 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)) 09:58:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:58:34 INFO - Running setup.py (path:/tmp/pip-jpFTnm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:58:35 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)) 09:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:58:35 INFO - Running setup.py (path:/tmp/pip-l6R18o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:58:35 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)) 09:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:58:35 INFO - Running setup.py (path:/tmp/pip-dvjWBj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:58:35 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)) 09:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:58:35 INFO - Running setup.py (path:/tmp/pip-JrFXYI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:58:35 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)) 09:58:35 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)) 09:58:35 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)) 09:58:35 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)) 09:58:35 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)) 09:58:35 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)) 09:58:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:58:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:36 INFO - Downloading blessings-1.5.1.tar.gz 09:58:36 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 09:58:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:58:37 INFO - Installing collected packages: blessings 09:58:37 INFO - Running setup.py install for blessings 09:58:37 INFO - Successfully installed blessings 09:58:37 INFO - Cleaning up... 09:58:37 INFO - Return code: 0 09:58:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:58:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:58:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:58:37 INFO - Reading from file tmpfile_stdout 09:58:37 INFO - Current package versions: 09:58:37 INFO - argparse == 1.2.1 09:58:37 INFO - blessings == 1.5.1 09:58:37 INFO - blobuploader == 1.2.4 09:58:37 INFO - docopt == 0.6.1 09:58:37 INFO - manifestparser == 1.1 09:58:37 INFO - mozInstall == 1.12 09:58:37 INFO - mozcrash == 0.16 09:58:37 INFO - mozdebug == 0.1 09:58:37 INFO - mozdevice == 0.47 09:58:37 INFO - mozfile == 1.2 09:58:37 INFO - mozhttpd == 0.7 09:58:37 INFO - mozinfo == 0.9 09:58:37 INFO - mozleak == 0.1 09:58:37 INFO - mozlog == 3.1 09:58:37 INFO - moznetwork == 0.27 09:58:37 INFO - mozprocess == 0.22 09:58:37 INFO - mozprofile == 0.28 09:58:37 INFO - mozrunner == 6.11 09:58:37 INFO - mozscreenshot == 0.1 09:58:37 INFO - mozsystemmonitor == 0.0 09:58:37 INFO - moztest == 0.7 09:58:37 INFO - mozversion == 1.4 09:58:37 INFO - psutil == 3.1.1 09:58:37 INFO - requests == 1.2.3 09:58:37 INFO - wsgiref == 0.1.2 09:58:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:58: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')]} 09:58:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58: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')]} 09:58:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:37 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 0x7fcf5fad1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b5dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13483d0>, '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 0x12b3ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b4360>, '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': '6dbc10da6d83fee962c624be000001a8-1452620691.459913-160078361', '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 09:58:37 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 09:58:37 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 09:58:37 INFO - Using env: {'DISPLAY': ':0', 09:58:37 INFO - 'HOME': '/home/cltbld', 09:58:37 INFO - 'LANG': 'en_US.UTF-8', 09:58:37 INFO - 'LANGUAGE': 'en_US:en', 09:58:37 INFO - 'LOGNAME': 'cltbld', 09:58:37 INFO - 'MAIL': '/var/mail/cltbld', 09:58:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:37 INFO - 'MOZ_NO_REMOTE': '1', 09:58:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:37 INFO - 'NO_EM_RESTART': '1', 09:58:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:37 INFO - 'PWD': '/builds/slave/test', 09:58:37 INFO - 'SHELL': '/bin/bash', 09:58:37 INFO - 'SHLVL': '1', 09:58:37 INFO - 'TERM': 'linux', 09:58:37 INFO - 'TMOUT': '86400', 09:58:37 INFO - 'USER': 'cltbld', 09:58:37 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1452620691.459913-160078361', 09:58:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:37 INFO - '_': '/tools/buildbot/bin/python'} 09:58:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:37 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)) 09:58:37 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)) 09:58:37 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)) 09:58:37 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)) 09:58:37 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)) 09:58:37 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)) 09:58:37 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)) 09:58:37 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)) 09:58:37 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)) 09:58:37 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)) 09:58:37 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)) 09:58:37 INFO - Cleaning up... 09:58:37 INFO - Return code: 0 09:58:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:58: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')]} 09:58:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58: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')]} 09:58:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:37 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 0x7fcf5fad1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b5dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13483d0>, '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 0x12b3ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b4360>, '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': '6dbc10da6d83fee962c624be000001a8-1452620691.459913-160078361', '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 09:58:37 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 09:58:37 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 09:58:37 INFO - Using env: {'DISPLAY': ':0', 09:58:37 INFO - 'HOME': '/home/cltbld', 09:58:37 INFO - 'LANG': 'en_US.UTF-8', 09:58:37 INFO - 'LANGUAGE': 'en_US:en', 09:58:37 INFO - 'LOGNAME': 'cltbld', 09:58:37 INFO - 'MAIL': '/var/mail/cltbld', 09:58:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:37 INFO - 'MOZ_NO_REMOTE': '1', 09:58:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:37 INFO - 'NO_EM_RESTART': '1', 09:58:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:37 INFO - 'PWD': '/builds/slave/test', 09:58:37 INFO - 'SHELL': '/bin/bash', 09:58:37 INFO - 'SHLVL': '1', 09:58:37 INFO - 'TERM': 'linux', 09:58:37 INFO - 'TMOUT': '86400', 09:58:37 INFO - 'USER': 'cltbld', 09:58:37 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1452620691.459913-160078361', 09:58:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:37 INFO - '_': '/tools/buildbot/bin/python'} 09:58:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:37 INFO - Downloading/unpacking jsonschema 09:58:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:58:39 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 09:58:39 INFO - Downloading/unpacking functools32 (from jsonschema) 09:58:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:39 INFO - Downloading functools32-3.2.3-2.tar.gz 09:58:39 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 09:58:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:58:39 INFO - warning: no files found matching '*.txt' 09:58:39 INFO - no previously-included directories found matching 'build' 09:58:39 INFO - no previously-included directories found matching 'dist' 09:58:39 INFO - no previously-included directories found matching '.git*' 09:58:39 INFO - Installing collected packages: jsonschema, functools32 09:58:39 INFO - Running setup.py install for functools32 09:58:39 INFO - warning: no files found matching '*.txt' 09:58:39 INFO - no previously-included directories found matching 'build' 09:58:39 INFO - no previously-included directories found matching 'dist' 09:58:39 INFO - no previously-included directories found matching '.git*' 09:58:39 INFO - Successfully installed jsonschema functools32 09:58:39 INFO - Cleaning up... 09:58:40 INFO - Return code: 0 09:58:40 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:58:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:40 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 0x7fcf5fad1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b5dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13483d0>, '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 0x12b3ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b4360>, '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': '6dbc10da6d83fee962c624be000001a8-1452620691.459913-160078361', '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 09:58:40 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 09:58:40 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 09:58:40 INFO - Using env: {'DISPLAY': ':0', 09:58:40 INFO - 'HOME': '/home/cltbld', 09:58:40 INFO - 'LANG': 'en_US.UTF-8', 09:58:40 INFO - 'LANGUAGE': 'en_US:en', 09:58:40 INFO - 'LOGNAME': 'cltbld', 09:58:40 INFO - 'MAIL': '/var/mail/cltbld', 09:58:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:40 INFO - 'MOZ_NO_REMOTE': '1', 09:58:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:40 INFO - 'NO_EM_RESTART': '1', 09:58:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:40 INFO - 'PWD': '/builds/slave/test', 09:58:40 INFO - 'SHELL': '/bin/bash', 09:58:40 INFO - 'SHLVL': '1', 09:58:40 INFO - 'TERM': 'linux', 09:58:40 INFO - 'TMOUT': '86400', 09:58:40 INFO - 'USER': 'cltbld', 09:58:40 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1452620691.459913-160078361', 09:58:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:40 INFO - '_': '/tools/buildbot/bin/python'} 09:58:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:40 INFO - Downloading/unpacking flake8 09:58:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:41 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:58:41 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 09:58:41 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:58:41 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 09:58:41 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 09:58:41 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 09:58:41 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 09:58:41 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 09:58:41 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 09:58:42 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:58:42 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 09:58:42 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:58:42 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 09:58:42 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 09:58:42 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 09:58:42 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 09:58:42 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 09:58:42 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 09:58:42 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 09:58:42 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:58:42 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 09:58:42 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 09:58:42 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 09:58:42 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 09:58:42 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 09:58:42 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 09:58:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 09:58:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:58:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:58:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:58:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:58:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:58:42 INFO - no previously-included directories found matching 'docs/_build' 09:58:42 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:58:42 INFO - Running setup.py install for pep8 09:58:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:58:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:58:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:58:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:58:42 INFO - no previously-included directories found matching 'docs/_build' 09:58:42 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:58:42 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:58:42 INFO - Cleaning up... 09:58:42 INFO - Return code: 0 09:58:42 INFO - Running post-action listener: _resource_record_post_action 09:58:42 INFO - Running post-action listener: _start_resource_monitoring 09:58:42 INFO - Starting resource monitoring. 09:58:42 INFO - ##### 09:58:42 INFO - ##### Running install step. 09:58:42 INFO - ##### 09:58:42 INFO - Running pre-action listener: _resource_record_pre_action 09:58:42 INFO - Running main action method: install 09:58:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:58:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:58:43 INFO - Reading from file tmpfile_stdout 09:58:43 INFO - Detecting whether we're running mozinstall >=1.0... 09:58:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:58:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:58:43 INFO - Reading from file tmpfile_stdout 09:58:43 INFO - Output received: 09:58:43 INFO - Usage: mozinstall [options] installer 09:58:43 INFO - Options: 09:58:43 INFO - -h, --help show this help message and exit 09:58:43 INFO - -d DEST, --destination=DEST 09:58:43 INFO - Directory to install application into. [default: 09:58:43 INFO - "/builds/slave/test"] 09:58:43 INFO - --app=APP Application being installed. [default: firefox] 09:58:43 INFO - mkdir: /builds/slave/test/build/application 09:58:43 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'] 09:58:43 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 09:58:58 INFO - Reading from file tmpfile_stdout 09:58:58 INFO - Output received: 09:58:58 INFO - /builds/slave/test/build/application/firefox/firefox 09:58:58 INFO - Running post-action listener: _resource_record_post_action 09:58:58 INFO - ##### 09:58:58 INFO - ##### Running run-tests step. 09:58:58 INFO - ##### 09:58:58 INFO - Running pre-action listener: _resource_record_pre_action 09:58:58 INFO - Running main action method: run_tests 09:58:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:58:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:58:58 INFO - Python 2.7.3 09:58:58 INFO - Return code: 0 09:58:58 INFO - grabbing minidump binary from tooltool 09:58:58 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')]} 09:58:58 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 0x13483d0>, '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 0x12b3ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b4360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:58:58 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 09:58:58 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 09:58:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:58:58 INFO - Return code: 0 09:58:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:58:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:58:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:58:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:58:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:58:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:58:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:58:59 INFO - Return code: 0 09:58:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fsoeQ2wFRF63tLB3ZtkL0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:58:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fsoeQ2wFRF63tLB3ZtkL0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:58:59 INFO - Using env: {'DISPLAY': ':0', 09:58:59 INFO - 'HOME': '/home/cltbld', 09:58:59 INFO - 'LANG': 'en_US.UTF-8', 09:58:59 INFO - 'LANGUAGE': 'en_US:en', 09:58:59 INFO - 'LOGNAME': 'cltbld', 09:58:59 INFO - 'MAIL': '/var/mail/cltbld', 09:58:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:58:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:58:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:59 INFO - 'MOZ_NO_REMOTE': '1', 09:58:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:58:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:59 INFO - 'NO_EM_RESTART': '1', 09:58:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:59 INFO - 'PWD': '/builds/slave/test', 09:58:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:58:59 INFO - 'SHELL': '/bin/bash', 09:58:59 INFO - 'SHLVL': '1', 09:58:59 INFO - 'TERM': 'linux', 09:58:59 INFO - 'TMOUT': '86400', 09:58:59 INFO - 'USER': 'cltbld', 09:58:59 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1452620691.459913-160078361', 09:58:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:59 INFO - '_': '/tools/buildbot/bin/python'} 09:58:59 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fsoeQ2wFRF63tLB3ZtkL0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:59:00 INFO - mozversion application_buildid: 20160112085155 09:59:00 INFO - mozversion application_changeset: 80d8340b39c19817224c09b31bfa412d96b29317 09:59:00 INFO - mozversion application_display_name: Nightly 09:59:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:59:00 INFO - mozversion application_name: Firefox 09:59:00 INFO - mozversion application_remotingname: firefox 09:59:00 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:59:00 INFO - mozversion application_vendor: Mozilla 09:59:00 INFO - mozversion application_version: 46.0a1 09:59:00 INFO - mozversion platform_buildid: 20160112085155 09:59:00 INFO - mozversion platform_changeset: 80d8340b39c19817224c09b31bfa412d96b29317 09:59:00 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:59:00 INFO - mozversion platform_version: 46.0a1 09:59:00 INFO - using testdate: 1452621540 09:59:00 INFO - actual date: 1452621540 09:59:00 INFO - starting webserver on 'localhost:40033' 09:59:00 INFO - SUITE-START | Running 3 tests 09:59:00 INFO - TEST-START | dromaeo_css 09:59:00 INFO - operating with platform_type : linux_ 09:59:00 INFO - Initialising browser for dromaeo_css test... 09:59:00 INFO - TEST-INFO | started process 8927 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5IjrB7/profile http://localhost:40033/getInfo.html) 09:59:03 INFO - PROCESS | 8927 | 09:59:03 INFO - PROCESS | 8927 | (process:9009): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:59:04 INFO - PROCESS | 8927 | __metrics Screen width/height:1600/1200 09:59:04 INFO - PROCESS | 8927 | colorDepth:24 09:59:04 INFO - PROCESS | 8927 | Browser inner width/height: 1024/697 09:59:04 INFO - PROCESS | 8927 | __metrics 09:59:04 INFO - PROCESS | 8927 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 09:59:05 INFO - TEST-INFO | 8927: exit 0 09:59:05 INFO - Browser initialized. 09:59:05 INFO - Running cycle 1/1 for dromaeo_css test... 09:59:05 INFO - TEST-INFO | started process 9058 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5IjrB7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:59:07 INFO - PROCESS | 9058 | 09:59:07 INFO - PROCESS | 9058 | (process:9113): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:59:17 INFO - PROCESS | 9058 | RSS: Main: 149655552 09:59:17 INFO - PROCESS | 9058 | 10:00:07 INFO - PROCESS | 9058 | 1452621607465 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:02:19 INFO - PROCESS | 9058 | Cycle 1(1): loaded http://localhost:40033/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40033/tests/dromaeo/cssquery-ext.html) 10:02:20 INFO - PROCESS | 9058 | RSS: Main: 152367104 10:02:20 INFO - PROCESS | 9058 | 10:05:22 INFO - PROCESS | 9058 | Cycle 1(1): loaded http://localhost:40033/tests/dromaeo/cssquery-ext.html (next: http://localhost:40033/tests/dromaeo/cssquery-jquery.html) 10:05:22 INFO - PROCESS | 9058 | RSS: Main: 150913024 10:05:22 INFO - PROCESS | 9058 | 10:08:24 INFO - PROCESS | 9058 | Cycle 1(1): loaded http://localhost:40033/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40033/tests/dromaeo/cssquery-mootools.html) 10:08:25 INFO - PROCESS | 9058 | RSS: Main: 151244800 10:08:25 INFO - PROCESS | 9058 | 10:11:27 INFO - PROCESS | 9058 | Cycle 1(1): loaded http://localhost:40033/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40033/tests/dromaeo/cssquery-prototype.html) 10:11:27 INFO - PROCESS | 9058 | RSS: Main: 150077440 10:11:27 INFO - PROCESS | 9058 | 10:14:30 INFO - PROCESS | 9058 | Cycle 1(1): loaded http://localhost:40033/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40033/tests/dromaeo/cssquery-yui.html) 10:14:30 INFO - PROCESS | 9058 | RSS: Main: 150855680 10:14:30 INFO - PROCESS | 9058 | 10:17:33 INFO - PROCESS | 9058 | Cycle 1(1): loaded http://localhost:40033/tests/dromaeo/cssquery-yui.html (next: http://localhost:40033/tests/dromaeo/cssquery-dojo.html) 10:17:33 INFO - PROCESS | 9058 | RSS: Main: 153546752 10:17:33 INFO - PROCESS | 9058 | 10:17:33 INFO - PROCESS | 9058 | __start_tp_report 10:17:33 INFO - PROCESS | 9058 | _x_x_mozilla_page_load 10:17:33 INFO - PROCESS | 9058 | _x_x_mozilla_page_load_details 10:17:33 INFO - PROCESS | 9058 | |i|pagename|runs| 10:17:33 INFO - PROCESS | 9058 | |0;dojo.html;2605.8566778827158;2615.8953641854323;2642.8767773696172;2651.42994256235;2671.4122892963546;4413.602775750186;4444.444444444444;4452.666050046243;4459.821607135711;4514.774261286939;4444.888877778058;4531.38826258455;4543.4547854257535;4544.863654090374;4595.609373203273;4201.39079833424;4235.68232382571;4240.21556012138;4283.643995802312;4291.9570804292025;4077.612626800449;4217.915641687165;4245.617894389505;4248.851290204843;4261.105167914741;4157.127003329305;4169.708120431586;4172.415861779354;4213.115245798386;4224.78876056196;4194.475690538683;4196.223698615766;4209.6000879916355;4212.4523811904255;4258.850940217078;4091.0386059276047;4167.854125105637;4181.498220213593;4186.5604111568155;4234.745915245096;4449.17690227309;4516.683832131752;4521.208788462006;4543.386642803245;4557.293619488984;4760;4795.0409918016185;4824.421069471686;4829.3721816164025;4874;4689.88275293117;4803.159447096779;4818.156822556039;4850.8059677612855;4859.781309841065;4502.054568540643;4531;4533.977330113361;4555.362249285103;4561.361409402686;4954.925676114861;4968.279599458058;4972.378452693413;4973.975130124326;5011.5489605935645;4620.44554653437;4676.742779147179;4751.049790042005;4767;4770.451398089194;4811.230203167476;4831.806727730922;4832.4684284728655;4861.27080937855;4870.439899411542;4766.666333356632;4776.59398951093;4781.187198176319;4788.066327066258;4830.855074347775;4593.977030114828;4698.765061746899;4733.668643195012;4764.499727528629;4822.68652537584;4053.3717273822604;4065.308897487434;4083.0404854859084;4090.6727461802984;4127.09203975125;3584.1756396028536;3599.8200089995394;3606.4229723244157;3622.239329740784;3626.655467730561;4081.551029386765;4137.048478849882;4194.559571245037;4241.066965267636;4268.807903644343;4836.854894353175;4880.365552478226;4881.926771098437;4913.754312284372;4920.065187614414;4059.89850253746;4219.282721937278;4225.345071513921;4227.767472788964;4268.338407546835;4208.431861698631;4306.41863348444;4331.198728235287;4334.26317526015;4362.781860906942;4641.74470404131;4665.206914824488;4669.089527542097;4681.859544213679;4705.717656940595;4797.928031079467;4871.8294859681155;4902.828401005948;4906.435759887516;4912.066707325596;4603.953960460352;4646.3727396801;4652.953470465387;4660.300954856799;4679.953200467951;4830.372051633265;4830.734309613005;4834.0331933612715;4842.564169224786;4871.707697538159;4776.928346074742;4841.540053694894;4857.854264371933;4879.804807807648;4919.532644398776;4673.7896794645;4697.271922851964;4710.081534100817;4735.905281894412;4742.051589682008;4678.274867395559;4684.484706682194;4692.976535117303;4707.105649926503;4733.810647574196;4555.453345598549;4556.726596404226;4598.057398233287;4616.653750968623;4654.743989080633;4740.597049250852;4781.9043619128115;4786.760661966958;4807.6153907688;4832.540908613676;4639.930401043919;4651.930221046619;4654.767261636837;4664.906701865876;4683.578477936866 10:17:33 INFO - PROCESS | 9058 | |1;ext.html;500.6645547483186;506.7289000384794;522.5662699959033;532.1299675031322;549.8158117030795;32713;33454.66545334543;33490.33019339615;33598.664013359856;33638.32723345532;37428.877133685965;37947.6718314859;38165;38281.23437531248;38317.0420739481;7493.288137626931;7710.768676939672;7722.536647801122;7737.226277372246;7758.495697779655;7452.962735186316;7564.962175189116;7628.275313845176;7760.961195194016;7793.337566306871;7684.65419056141;7879.4878332908465;7883.605819709021;7892.250236227549;7903.209679032108;7739.57432341221;7797.610119494031;7799.181085986003;7808.336291415179;7823.178566250575;7464.178940316561;7608.277213664693;7610.809729756745;7621.504602200839;7675.19410461899;36521;36667;36805;36863.63136368629;37030.22273329484;2446.156076153724;2804.3690169711654;2922.0941508132546;3022.531507616323;3680.35593771089;25969.74030259711;26279.868600657064;26355.34111647205;26490.47019059608;26671;3277.311764529428;3286.605607327112;3300.5214243934734;3375.426177549798;3393.049946015095;172451;173795;173955;174213;174453.12773436052;46495.767521162175;47924.04151916942;49124.263136052985;49241.26138107931;54047.45952540503;47741.5225847744;47857;48058.27912581314;48107.518924811004;48274.27588586174;13018.414171362121;13179.341032948507;13196.20822750638;13204.141730787467;13205.075644704779;10163.695089147337;10227.539760710786;10234.130098941525;10243.436610986468;10246.692599221886;17820.5249976256;18086.638267234583;18575.44273671792;18677.252909883726;18742.718859217122;7298.781036568806;7486.7005319786595;7529.548227106391;7535.255945928473;7552.282533159341;830.1608498933541;890.3856339125982;897.7665806890125;920.963161473547;938.3337830140676;25890.87054564753;26897;27041.864790676314;27063.86468067647;27297.181084567495;931.3061768982017;966.0918736387773;992.0922356044283;998.510729742421;1074.8011617850566;13538.93230533841;14034.546422688562;14448.349824257934;14781.26093695311;14900.70198596022;258097;265426;267083;267937;267992;38100.42849357262;38165.236695265936;38275.23449530994;38332;38421.423678644845;1226.4113225651738;1233.3031837012059;1235.2897084176634;1257.962181200495;1262.211118051218;23224.76775232226;23745.287641370785;23800.523989520458;23815.52368952646;25055.87472062628;45534.316985244586;46913.06173876435;47084;47201.291980621005;47226.527734722215;199553;200338;200849;201079;201134;28316.575251371658;28801.855990719912;29011;29138.417231654825;29486.262843429085;33221.33557328791;33341;33497.665023350426;33716.662833372335;34002.659973400936;28554;28841.278968025967;28923.566146507397;28935.56596651094;29476.410471790015;30342.696573033987;30468;31040.223994399417;31372.843135784176;31691.52462713015;31467.52798708067;32611;33471;33670.3265934675;33882.49176262309;25360.619590705785;26817.463650726488;27544.311392215353;27693;29271.85364073166;23057.308280751604;23099.76900230976;23149;23398.883005584863;23457.296281111594 10:17:33 INFO - PROCESS | 9058 | |2;jquery.html;346.88649435312647;350.0967503840093;350.2749308930513;350.72117666455165;350.8070561191344;14594;14874.925625371872;15269.847301526981;16007.519774406757;16439.753403698953;14340.139591624484;14435.133891966489;15166.317515711791;15197.772033419507;15201.54395368138;4335.34969754537;4703.059388122372;4726.763661816913;4726.952730472703;4733.148033354012;4532.297493888436;4580.473245576768;4659.5573420525;4659.813607455698;4671.88320291992;4810;4999.900001999976;5026.648134630577;5032.874178145539;5078.822241221558;4872.65891387603;4879.780409881546;4883.731394773268;4911.312416261726;5666.5183459406;5029.4216165141115;5037.798488060474;5043.84868453947;5055.165897626887;5057.140286151363;11151.330920144817;16073.276702548414;17563.473095807145;18360.724589131172;18485.907570462197;1807.358387772335;1864.3754342295347;1867.6918308479085;1877.586930875219;1890.3194849854042;8512.1487851215;8643.783905402352;8673.13268673134;8852.114788521161;9112.772180695536;1669.0569828047237;1688.3415467967502;1722.4402069327393;1782.7236778299384;1795.9942432237988;49312.753436232946;50957.490425095646;51390.22914656283;51527;52051.73974130143;9394.67118650844;9643.27675424346;9763.658271960589;9769.413835169913;9769.462679552551;12502.249865008129;12533.56132535375;12540.310282934344;12563.937180314222;12565.74868502643;6480.870382592322;6497.9675101625135;6566.80299591013;6629.370209830058;6841.897371539431;6450.41946224842;6460.773872914426;6473.385028422293;6499.350064993463;6613.371729685672;4132.442120313719;4153.6677065834665;4211.642010429086;4224.471941007374;4266.530681625019;1695.2117265471616;1795.5870149865605;1819.1631849349183;1820.8270214329618;1826.5798866260834;772.3628006894222;836.0844874862138;836.9497830130211;850.268768858781;870.6082262981683;14470.927645361706;14845.777313340308;15174.924125379302;15228.847711522743;15338.693226135638;838.5136620759945;848.5036253791601;880.124276345028;902.5577467041103;918.5956351891328;8610.78473038179;8836.646534138563;8877;8903.599338029804;9037;441678;448915;448998;455871;455965;59122.40877591169;62118;63188.36811631825;64950.67524662346;65152.67423662851;1032.8037672842286;1035.3839465518004;1043.2644985285356;1045.4929359260752;1049.5959055763585;13572.253526056162;13649.839763620204;13753.862461375258;13869.375878085712;14164.291785410895;30517.23706907345;30794.692053079183;30922.69077309288;31001.8449907749;31162;39202;39432.80283598564;40077;40109.197816042935;41738.95652608709;6627.701753421204;6740.62926539045;6822.624755638488;6872.587644741331;6997.510174287751;9524.285678574273;9694.418334899929;9807.754806129904;9921.851172232567;10036.749081273027;8057.798555036171;8236.917630823615;8284.46151000183;8339.874901876598;8674.522901240493;8469.576521173793;8794.20852123312;9014.368994170607;9082.36423450352;9210;2679.4105296834664;3383.917146513092;3553.911152221215;8923.643054277756;9233.492157931378;6860.348266914635;7132.108486439195;7243.674034668347;7261.455390845814;7299.248195419322;7858.253465920729;9034.593443295198;9054.275657947217;9068.455892646462;9126.406783559047 10:17:33 INFO - PROCESS | 9058 | |3;mootools.html;1375.972480550389;1419.5954153066375;1545.6290490282336;1725.6117373590935;1751.6846967545844;7260.056192694949;7285.307895749908;7461.477696561243;7474.32731054205;7499.775006749799;7440.7767766966945;7489.251074892508;7504.81237969051;7543.849123017536;7545.7358992435275;2175.7280339957506;2226.0984301357894;2226.6214743493647;2226.977730222693;2228.3426389215138;2190.3210004898533;2201.471646804763;2218.057325636598;2219.411855858191;2221.4557433428754;1795.9012254326008;1839.2551016838202;2053.887036213008;2168.6746987951856;2206.3491270075365;2107.8735275883496;2113.947151321214;2121.2151503943564;2121.374194612593;2122.214780531198;1973.2797528901847;2002.5894691588335;2011.2759406613607;2020.2525065725629;2021.1309137071053;7114.928850711479;7159.89260161098;7161.641917904136;7175.820604484878;7182.066331376887;4198.433211516437;4296.183725092223;4345.696291112685;4350.303951367798;4356.607905288539;2621.9475610487684;2626.3828000419885;2657.2161212442184;2717.877695503707;2718.0486829609677;866.4844417571597;885.28292083412;887.6094518411878;895.6104094718818;919.5310391700215;10074.244431667581;10139.695809125738;10228.590856365736;10243.539040743184;10264.23018273625;3850.403187505941;3976.8210430530694;4000.5399379071196;4015.4579131817413;4056.14820887611;8260.421770476129;8313.33493320533;8318.126596707258;8337.416380853403;8350.665973360998;4404.977975110168;4415.845445409395;4427.203103441347;4431.202383570988;4447.399601053881;3997.8200980955926;4000.979995100064;4060.167665628539;4063.227986682521;4090.877273681794;3104.9379012419627;3175.841207939594;3178.332550164445;3182.5226216067776;3208.422483952911;932.2029664636638;941.4492521874643;944.2729098594044;947.2611363136626;958.8082383523323;973.3478569358547;978.3151793744265;1018.9847152292722;1035.6737627647267;1188.417675339095;6871.415929645936;6901.102856628606;6910.136232970879;6921.204061532988;6942.132233470817;1028.7376718936623;1043.415687215162;1054.6256079091966;1056.1128651932413;1073.0771536478621;5413;5463.262459567907;5482;5497.835064948058;5502.367227768777;8775.868361974575;8888.155625215593;8971.416857904216;9014.684486043088;9071.27429805614;8865.379423440427;8976.640934362553;9020.14308640678;9028.729138125867;9039.322050846213;6648.800535983928;6895.689693963684;6950.20072691647;7143.928410738431;7143.999840022401;6821.693023814039;6875.724971001304;6883.621400823003;6896.27589103157;6938.028675985265;7801.258880406353;7953.204679532232;7962.562059086806;7999.6400161994015;8114.837703245784;7764.883526747216;7942.523448593103;7954.125046244792;7966.482178658369;8065.798355040936;6427.453666438405;6451.290358060516;6514.771982980573;6518.087467754423;6607.9669601651685;6733.494987875831;6835.282295359115;6847.62338071391;6849.794506164823;6854.280300568568;6557.9344206559235;6698.765543205965;6721.798346049626;6744.932550674626;6770.119884414995;5602.439756024365;5716.914246286392;6195.287541932736;6377.7130029147875;6547.1161393211305;6662.300458451987;6700.095487109373;6742.292059333699;6744.494162937701;6748.493862960199;6088.299845517822;6144.600600960924;6157.692115394302;6174.753009879554;6195.008798592204;6134.171886795226;6173.104899789595;6188.938110619017;6189.907151392823;6194.752209911553 10:17:33 INFO - PROCESS | 9058 | |4;prototype.html;299.1877053798936;300.0862374070953;307.1767662664061;312.6248501797842;313.2372672542358;5582.274304340435;5625.859353516164;5649.3220813502385;5720.685362305072;5771.5959882808165;5575.219469274305;5658.207850900877;5684.772609095641;5686.09022556391;5707.828765137042;4324.437823083011;4326.805293761772;4328.610425061744;4329.588689074533;4338;4336.783160841946;4337.893837071542;4339.784860239122;4342.934855977162;4349.8695039148715;3973.662238709713;3974.165425260684;4161.334186530155;4235.915281694364;4301.182775272689;4177.937330940038;4178.811953462102;4180.623743863037;4189.811458484375;4208.684348673831;3616.8734094306574;3621.5835178954494;3626.8367923443243;3630.7640003399692;3638.326909521747;5397.487238712355;5402.432744561804;5403.351597808288;5431.646942948696;5434.673919564839;4776.641751868624;4867.294242334877;4868.9756551217015;4870.65905386623;4922.114019476493;5877.147813567009;5887.4406931341455;5898.056310990264;5910.438508341701;5913.822585322448;4047.4131250968444;4051.493563304587;4054.7567145971334;4055.1078762672164;4062.5531191568903;6160.552270216495;6254.21822272216;6261.96869015652;6267.62394256346;6270.498360131224;4122.361034039729;4159.9376009359885;4178.603032711888;4240.575942405735;4256.5105012923295;4286.249906266391;4292.5063617683745;4296.2481565725875;4299.6775241856985;4310.590493903074;4885;4890.217565189552;4894.11905856942;4903.411590609078;4910.337104490919;5806.419358064244;5817.272840894888;5905.793297234576;5927.762889484458;5929.199558059693;1492.604459818149;1508.6982603479128;1540.892137550383;1556.8323757182113;1557.5249548887698;1018.8420794776821;1036.8652075230173;1039.9688009359731;1042.629866397418;1055.171690223171;5032.370953630796;5076.822311219164;5087.592992560661;5097.490250974873;5107.157319042391;6084.5132389408745;6088.238970128734;6102.145699602059;6118.60229085108;6133.44798968095;5063.291139240509;5077.1876499759865;5080.339555857789;5083.415407228142;5106.46382129871;3203.9679603204136;3261.673832616767;3280.0815771583993;3302.091924720721;3313.950290745641;5763.971180144073;5765.106408506688;5774.68239246837;5781.335146458127;5801.767929282782;6288.213973253343;6311.842203944938;6320.747170113144;6325.177726895474;6334.968325158345;5601.131824567198;5780.335261444903;5786;5788.652680839163;5793.2179155814265;6113.388661134029;6119.296280927572;6128.63228206309;6129.724162412613;6132.5707200495535;5919.940800591939;5933.169356290036;5947.553933454921;5951.047832346804;5955.970220148872;5726.198332233407;5757.798477053283;5763.567732420169;5764.740586673526;5766.423357664368;4013.618706222904;4148.502179738451;4149.356849688304;4150.190712810973;4342.761148136757;5982.312034116132;6088.695565221809;6149.2313460817395;6157.291911430064;6205.162303089025;5951.315598706205;5970.5223582114195;5986.2217911671205;5987.790427335022;5988.700564971821;5927.614705044159;5942.524598032061;5975.9103613446705;5985.551083668829;5988.490978266722;5693.146028095819;5797.710114494343;5852.151438041546;5852.795152169653;5861.35525092248;6001.969990150022;6018.849528761641;6019.6990150493175;6023.728932198149;6040.728167232573;5804.071348584206;5817.592768506164;5825.242718446575;5840.123981402823;5840.561957853093 10:17:33 INFO - PROCESS | 9058 | |5;yui.html;771.1555846348247;782.170898847222;787.9921200787998;793.7618714385685;798.4769975665937;11487;11605.883941160586;11624.709382265448;11628.476718547665;11662;11119.165337719287;11226.831597526023;11278.421021057058;11312.151588630844;11331.886681133186;766.2605585609899;775.0970119810414;780.6135962698472;781.663884529652;781.9178986206451;765.185077892046;770.6146926536732;771.2441807029115;772.3589420780738;773.2422226218309;817.791463176889;818.0510607695074;819.5533434278333;820.2658620534618;821.9260266576007;801.3669201330941;808.2846680687634;812.0296245986049;812.2446125103651;813.1868131868132;599.6192417814675;602.6745557399043;602.8342205893414;603.3604379357895;604.1270364323555;9244.676436324764;9252.722418327461;9275.58259878307;9287.071292870727;9321.300902432346;9470.621175152986;9656.951715241448;9700.36947598411;10058.04448577384;10327.225458090597;8355.373346998938;8659.177378149128;8683.739487815375;8718.34612404066;8798.164174403486;3125.3280544683003;3207.262329664167;3208.2300247940325;3228.3543291341825;3259;37978.81010594929;39082.804585977174;39101.60898391008;39147.60852391468;39442.21115577672;9135.862962055575;9149.222316103072;9194.862077068849;9272.350935434455;9373.718788436357;14736;14769.630759231106;14781;14783.113013219241;14793.630159246104;6386.84032899172;6472.644004579699;6537.444317233088;6553.803385898431;6605.339466053452;3543.3799085159994;3543.698785603201;3549.5563054618174;3557.7153827693724;3562.928741425157;2601.245638764737;2637.31429828246;2640.4983053219826;2643.4052338223746;2646.801489888266;480.6419217682779;488.2456604545914;489.59119135521524;490.5682998960963;498.14816663505087;476.7044432451902;574.2850151561333;578.2713780636428;596.4780816785313;626.7023163997156;7701.691932322757;7914.287714105643;8043.879341809878;8073.677052917935;8075.919240807634;430.9310510318334;474.8029567729354;495.38077403245944;508.80919655129327;521.4707072321596;2982.7017298270434;3053.8167709937475;3106.819408624708;3112.8910488132806;3375.5443015192636;40515.39226911599;40778.59221407748;40898.79550602228;41005.1798964025;41143.7942810284;39593.802030990235;40619.7969010159;42821.57178428238;42875.78562107169;43109.78445107755;33928;34355;37272.25455490875;38682.61317386846;38949.22101558009;7773.261540153676;8232.464889782144;8315.916840831514;8474.449160804528;8544.658213671384;29339.41321173607;29773.404531908807;30072.3985520284;30330.545041824833;30687.693123068482;35203.64796352004;35206;39281.017974550865;39721;40161;10288.691339259834;10422.270441069053;10590.4704764763;10623.415712135598;10695.94652026735;11146.219764616399;11324.830127547928;11345.886541134812;11445.25605835618;11823.822642660194;10477.738056548647;10496.68509944703;10785.137189025016;10947.50736216888;11124.888751112385;10400.167986560906;10602.787944241227;10674.146068314361;11178.664640060812;11215;10843.67468975932;10898.564057437614;11291.774164516828;11452.026577740986;11454.541818327174;8264.21489958453;8736.25741811953;8842.867356989778;9205.815883682422;9391.342606017513;8482.703105391281;8961.283097352327;8987.775305617412;9054;9140.131687489678 10:17:33 INFO - PROCESS | 9058 | __end_tp_report 10:17:33 INFO - PROCESS | 9058 | __start_cc_report 10:17:33 INFO - PROCESS | 9058 | _x_x_mozilla_cycle_collect,322 10:17:33 INFO - PROCESS | 9058 | __end_cc_report 10:17:33 INFO - PROCESS | 9058 | __startTimestamp1452622653661__endTimestamp 10:17:33 INFO - PROCESS | 9058 | 10:17:33 INFO - PROCESS | 9058 | ------- Summary: start ------- 10:17:33 INFO - PROCESS | 9058 | Number of tests: 6 10:17:33 INFO - PROCESS | 9058 | 10:17:33 INFO - PROCESS | 9058 | [#0] dojo.html Cycles:165 Average:4485.08 Median:4639.93 stddev:450.44 (9.7%) stddev-sans-first:427.02 10:17:33 INFO - PROCESS | 9058 | Values: 2605.9 2615.9 2642.9 2651.4 2671.4 4413.6 4444.4 4452.7 4459.8 4514.8 4444.9 4531.4 4543.5 4544.9 4595.6 4201.4 4235.7 4240.2 4283.6 4292.0 4077.6 4217.9 4245.6 4248.9 4261.1 4157.1 4169.7 4172.4 4213.1 4224.8 4194.5 4196.2 4209.6 4212.5 4258.9 4091.0 4167.9 4181.5 4186.6 4234.7 4449.2 4516.7 4521.2 4543.4 4557.3 4760.0 4795.0 4824.4 4829.4 4874.0 4689.9 4803.2 4818.2 4850.8 4859.8 4502.1 4531.0 4534.0 4555.4 4561.4 4954.9 4968.3 4972.4 4974.0 5011.5 4620.4 4676.7 4751.0 4767.0 4770.5 4811.2 4831.8 4832.5 4861.3 4870.4 4766.7 4776.6 4781.2 4788.1 4830.9 4594.0 4698.8 4733.7 4764.5 4822.7 4053.4 4065.3 4083.0 4090.7 4127.1 3584.2 3599.8 3606.4 3622.2 3626.7 4081.6 4137.0 4194.6 4241.1 4268.8 4836.9 4880.4 4881.9 4913.8 4920.1 4059.9 4219.3 4225.3 4227.8 4268.3 4208.4 4306.4 4331.2 4334.3 4362.8 4641.7 4665.2 4669.1 4681.9 4705.7 4797.9 4871.8 4902.8 4906.4 4912.1 4604.0 4646.4 4653.0 4660.3 4680.0 4830.4 4830.7 4834.0 4842.6 4871.7 4776.9 4841.5 4857.9 4879.8 4919.5 4673.8 4697.3 4710.1 4735.9 4742.1 4678.3 4684.5 4693.0 4707.1 4733.8 4555.5 4556.7 4598.1 4616.7 4654.7 4740.6 4781.9 4786.8 4807.6 4832.5 4639.9 4651.9 4654.8 4664.9 4683.6 10:17:33 INFO - PROCESS | 9058 | 10:17:33 INFO - PROCESS | 9058 | [#1] ext.html Cycles:180 Average:36820.28 Median:18260.93 stddev:56349.41 (308.6%) stddev-sans-first:56441.49 10:17:33 INFO - PROCESS | 9058 | Values: 500.7 506.7 522.6 532.1 549.8 32713.0 33454.7 33490.3 33598.7 33638.3 37428.9 37947.7 38165.0 38281.2 38317.0 7493.3 7710.8 7722.5 7737.2 7758.5 7453.0 7565.0 7628.3 7761.0 7793.3 7684.7 7879.5 7883.6 7892.3 7903.2 7739.6 7797.6 7799.2 7808.3 7823.2 7464.2 7608.3 7610.8 7621.5 7675.2 36521.0 36667.0 36805.0 36863.6 37030.2 2446.2 2804.4 2922.1 3022.5 3680.4 25969.7 26279.9 26355.3 26490.5 26671.0 3277.3 3286.6 3300.5 3375.4 3393.0 172451.0 173795.0 173955.0 174213.0 174453.1 46495.8 47924.0 49124.3 49241.3 54047.5 47741.5 47857.0 48058.3 48107.5 48274.3 13018.4 13179.3 13196.2 13204.1 13205.1 10163.7 10227.5 10234.1 10243.4 10246.7 17820.5 18086.6 18575.4 18677.3 18742.7 7298.8 7486.7 7529.5 7535.3 7552.3 830.2 890.4 897.8 921.0 938.3 25890.9 26897.0 27041.9 27063.9 27297.2 931.3 966.1 992.1 998.5 1074.8 13538.9 14034.5 14448.3 14781.3 14900.7 258097.0 265426.0 267083.0 267937.0 267992.0 38100.4 38165.2 38275.2 38332.0 38421.4 1226.4 1233.3 1235.3 1258.0 1262.2 23224.8 23745.3 23800.5 23815.5 25055.9 45534.3 46913.1 47084.0 47201.3 47226.5 199553.0 200338.0 200849.0 201079.0 201134.0 28316.6 28801.9 29011.0 29138.4 29486.3 33221.3 33341.0 33497.7 33716.7 34002.7 28554.0 28841.3 28923.6 28935.6 29476.4 30342.7 30468.0 31040.2 31372.8 31691.5 31467.5 32611.0 33471.0 33670.3 33882.5 25360.6 26817.5 27544.3 27693.0 29271.9 23057.3 23099.8 23149.0 23398.9 23457.3 10:17:33 INFO - PROCESS | 9058 | 10:17:33 INFO - PROCESS | 9058 | [#2] jquery.html Cycles:180 Average:23778.15 Median:4876.22 stddev:73578.41 (1508.9%) stddev-sans-first:73763.78 10:17:33 INFO - PROCESS | 9058 | Values: 346.9 350.1 350.3 350.7 350.8 14594.0 14874.9 15269.8 16007.5 16439.8 14340.1 14435.1 15166.3 15197.8 15201.5 4335.3 4703.1 4726.8 4727.0 4733.1 4532.3 4580.5 4659.6 4659.8 4671.9 4810.0 4999.9 5026.6 5032.9 5078.8 4872.7 4879.8 4883.7 4911.3 5666.5 5029.4 5037.8 5043.8 5055.2 5057.1 11151.3 16073.3 17563.5 18360.7 18485.9 1807.4 1864.4 1867.7 1877.6 1890.3 8512.1 8643.8 8673.1 8852.1 9112.8 1669.1 1688.3 1722.4 1782.7 1796.0 49312.8 50957.5 51390.2 51527.0 52051.7 9394.7 9643.3 9763.7 9769.4 9769.5 12502.2 12533.6 12540.3 12563.9 12565.7 6480.9 6498.0 6566.8 6629.4 6841.9 6450.4 6460.8 6473.4 6499.4 6613.4 4132.4 4153.7 4211.6 4224.5 4266.5 1695.2 1795.6 1819.2 1820.8 1826.6 772.4 836.1 836.9 850.3 870.6 14470.9 14845.8 15174.9 15228.8 15338.7 838.5 848.5 880.1 902.6 918.6 8610.8 8836.6 8877.0 8903.6 9037.0 441678.0 448915.0 448998.0 455871.0 455965.0 59122.4 62118.0 63188.4 64950.7 65152.7 1032.8 1035.4 1043.3 1045.5 1049.6 13572.3 13649.8 13753.9 13869.4 14164.3 30517.2 30794.7 30922.7 31001.8 31162.0 39202.0 39432.8 40077.0 40109.2 41739.0 6627.7 6740.6 6822.6 6872.6 6997.5 9524.3 9694.4 9807.8 9921.9 10036.7 8057.8 8236.9 8284.5 8339.9 8674.5 8469.6 8794.2 9014.4 9082.4 9210.0 2679.4 3383.9 3553.9 8923.6 9233.5 6860.3 7132.1 7243.7 7261.5 7299.2 7858.3 9034.6 9054.3 9068.5 9126.4 10:17:33 INFO - PROCESS | 9058 | 10:17:33 INFO - PROCESS | 9058 | [#3] mootools.html Cycles:180 Average:5123.11 Median:6286.50 stddev:2692.45 (42.8%) stddev-sans-first:2685.27 10:17:33 INFO - PROCESS | 9058 | Values: 1376.0 1419.6 1545.6 1725.6 1751.7 7260.1 7285.3 7461.5 7474.3 7499.8 7440.8 7489.3 7504.8 7543.8 7545.7 2175.7 2226.1 2226.6 2227.0 2228.3 2190.3 2201.5 2218.1 2219.4 2221.5 1795.9 1839.3 2053.9 2168.7 2206.3 2107.9 2113.9 2121.2 2121.4 2122.2 1973.3 2002.6 2011.3 2020.3 2021.1 7114.9 7159.9 7161.6 7175.8 7182.1 4198.4 4296.2 4345.7 4350.3 4356.6 2621.9 2626.4 2657.2 2717.9 2718.0 866.5 885.3 887.6 895.6 919.5 10074.2 10139.7 10228.6 10243.5 10264.2 3850.4 3976.8 4000.5 4015.5 4056.1 8260.4 8313.3 8318.1 8337.4 8350.7 4405.0 4415.8 4427.2 4431.2 4447.4 3997.8 4001.0 4060.2 4063.2 4090.9 3104.9 3175.8 3178.3 3182.5 3208.4 932.2 941.4 944.3 947.3 958.8 973.3 978.3 1019.0 1035.7 1188.4 6871.4 6901.1 6910.1 6921.2 6942.1 1028.7 1043.4 1054.6 1056.1 1073.1 5413.0 5463.3 5482.0 5497.8 5502.4 8775.9 8888.2 8971.4 9014.7 9071.3 8865.4 8976.6 9020.1 9028.7 9039.3 6648.8 6895.7 6950.2 7143.9 7144.0 6821.7 6875.7 6883.6 6896.3 6938.0 7801.3 7953.2 7962.6 7999.6 8114.8 7764.9 7942.5 7954.1 7966.5 8065.8 6427.5 6451.3 6514.8 6518.1 6608.0 6733.5 6835.3 6847.6 6849.8 6854.3 6557.9 6698.8 6721.8 6744.9 6770.1 5602.4 5716.9 6195.3 6377.7 6547.1 6662.3 6700.1 6742.3 6744.5 6748.5 6088.3 6144.6 6157.7 6174.8 6195.0 6134.2 6173.1 6188.9 6189.9 6194.8 10:17:33 INFO - PROCESS | 9058 | 10:17:33 INFO - PROCESS | 9058 | [#4] prototype.html Cycles:180 Average:4878.81 Median:5578.75 stddev:1454.99 (26.1%) stddev-sans-first:1417.88 10:17:33 INFO - PROCESS | 9058 | Values: 299.2 300.1 307.2 312.6 313.2 5582.3 5625.9 5649.3 5720.7 5771.6 5575.2 5658.2 5684.8 5686.1 5707.8 4324.4 4326.8 4328.6 4329.6 4338.0 4336.8 4337.9 4339.8 4342.9 4349.9 3973.7 3974.2 4161.3 4235.9 4301.2 4177.9 4178.8 4180.6 4189.8 4208.7 3616.9 3621.6 3626.8 3630.8 3638.3 5397.5 5402.4 5403.4 5431.6 5434.7 4776.6 4867.3 4869.0 4870.7 4922.1 5877.1 5887.4 5898.1 5910.4 5913.8 4047.4 4051.5 4054.8 4055.1 4062.6 6160.6 6254.2 6262.0 6267.6 6270.5 4122.4 4159.9 4178.6 4240.6 4256.5 4286.2 4292.5 4296.2 4299.7 4310.6 4885.0 4890.2 4894.1 4903.4 4910.3 5806.4 5817.3 5905.8 5927.8 5929.2 1492.6 1508.7 1540.9 1556.8 1557.5 1018.8 1036.9 1040.0 1042.6 1055.2 5032.4 5076.8 5087.6 5097.5 5107.2 6084.5 6088.2 6102.1 6118.6 6133.4 5063.3 5077.2 5080.3 5083.4 5106.5 3204.0 3261.7 3280.1 3302.1 3314.0 5764.0 5765.1 5774.7 5781.3 5801.8 6288.2 6311.8 6320.7 6325.2 6335.0 5601.1 5780.3 5786.0 5788.7 5793.2 6113.4 6119.3 6128.6 6129.7 6132.6 5919.9 5933.2 5947.6 5951.0 5956.0 5726.2 5757.8 5763.6 5764.7 5766.4 4013.6 4148.5 4149.4 4150.2 4342.8 5982.3 6088.7 6149.2 6157.3 6205.2 5951.3 5970.5 5986.2 5987.8 5988.7 5927.6 5942.5 5975.9 5985.6 5988.5 5693.1 5797.7 5852.2 5852.8 5861.4 6002.0 6018.8 6019.7 6023.7 6040.7 5804.1 5817.6 5825.2 5840.1 5840.6 10:17:33 INFO - PROCESS | 9058 | 10:17:33 INFO - PROCESS | 9058 | [#5] yui.html Cycles:180 Average:11520.13 Median:21653.36 stddev:12563.13 (58.0%) stddev-sans-first:12572.44 10:17:33 INFO - PROCESS | 9058 | Values: 771.2 782.2 788.0 793.8 798.5 11487.0 11605.9 11624.7 11628.5 11662.0 11119.2 11226.8 11278.4 11312.2 11331.9 766.3 775.1 780.6 781.7 781.9 765.2 770.6 771.2 772.4 773.2 817.8 818.1 819.6 820.3 821.9 801.4 808.3 812.0 812.2 813.2 599.6 602.7 602.8 603.4 604.1 9244.7 9252.7 9275.6 9287.1 9321.3 9470.6 9657.0 9700.4 10058.0 10327.2 8355.4 8659.2 8683.7 8718.3 8798.2 3125.3 3207.3 3208.2 3228.4 3259.0 37978.8 39082.8 39101.6 39147.6 39442.2 9135.9 9149.2 9194.9 9272.4 9373.7 14736.0 14769.6 14781.0 14783.1 14793.6 6386.8 6472.6 6537.4 6553.8 6605.3 3543.4 3543.7 3549.6 3557.7 3562.9 2601.2 2637.3 2640.5 2643.4 2646.8 480.6 488.2 489.6 490.6 498.1 476.7 574.3 578.3 596.5 626.7 7701.7 7914.3 8043.9 8073.7 8075.9 430.9 474.8 495.4 508.8 521.5 2982.7 3053.8 3106.8 3112.9 3375.5 40515.4 40778.6 40898.8 41005.2 41143.8 39593.8 40619.8 42821.6 42875.8 43109.8 33928.0 34355.0 37272.3 38682.6 38949.2 7773.3 8232.5 8315.9 8474.4 8544.7 29339.4 29773.4 30072.4 30330.5 30687.7 35203.6 35206.0 39281.0 39721.0 40161.0 10288.7 10422.3 10590.5 10623.4 10695.9 11146.2 11324.8 11345.9 11445.3 11823.8 10477.7 10496.7 10785.1 10947.5 11124.9 10400.2 10602.8 10674.1 11178.7 11215.0 10843.7 10898.6 11291.8 11452.0 11454.5 8264.2 8736.3 8842.9 9205.8 9391.3 8482.7 8961.3 8987.8 9054.0 9140.1 10:17:33 INFO - PROCESS | 9058 | -------- Summary: end -------- 10:17:33 INFO - PROCESS | 9058 | 10:17:34 INFO - TEST-INFO | 9058: exit 0 10:17:34 INFO - TEST-OK | dromaeo_css | took 1114340ms 10:17:34 INFO - TEST-START | kraken 10:17:34 INFO - operating with platform_type : linux_ 10:17:34 INFO - Initialising browser for kraken test... 10:17:34 INFO - TEST-INFO | started process 9290 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGqMLxL/profile http://localhost:40033/getInfo.html) 10:17:38 INFO - PROCESS | 9290 | 10:17:38 INFO - PROCESS | 9290 | (process:9361): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:17:39 INFO - PROCESS | 9290 | __metrics Screen width/height:1600/1200 10:17:39 INFO - PROCESS | 9290 | colorDepth:24 10:17:39 INFO - PROCESS | 9290 | Browser inner width/height: 1024/697 10:17:39 INFO - PROCESS | 9290 | __metrics 10:17:39 INFO - PROCESS | 9290 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:17:40 INFO - TEST-INFO | 9290: exit 0 10:17:40 INFO - Browser initialized. 10:17:40 INFO - Running cycle 1/1 for kraken test... 10:17:40 INFO - TEST-INFO | started process 9410 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGqMLxL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:17:41 INFO - PROCESS | 9410 | 10:17:41 INFO - PROCESS | 9410 | (process:9468): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:17:52 INFO - PROCESS | 9410 | RSS: Main: 150183936 10:17:52 INFO - PROCESS | 9410 | 10:17:54 INFO - PROCESS | 9410 | Cycle 1(1): loaded http://localhost:40033/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40033/tests/kraken/driver.html?testName=audio-beat-detection) 10:17:55 INFO - PROCESS | 9410 | RSS: Main: 150777856 10:17:55 INFO - PROCESS | 9410 | 10:17:58 INFO - PROCESS | 9410 | Cycle 1(1): loaded http://localhost:40033/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40033/tests/kraken/driver.html?testName=audio-dft) 10:17:58 INFO - PROCESS | 9410 | RSS: Main: 150319104 10:17:58 INFO - PROCESS | 9410 | 10:18:01 INFO - PROCESS | 9410 | Cycle 1(1): loaded http://localhost:40033/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40033/tests/kraken/driver.html?testName=audio-fft) 10:18:02 INFO - PROCESS | 9410 | RSS: Main: 146874368 10:18:02 INFO - PROCESS | 9410 | 10:18:04 INFO - PROCESS | 9410 | Cycle 1(1): loaded http://localhost:40033/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40033/tests/kraken/driver.html?testName=audio-oscillator) 10:18:05 INFO - PROCESS | 9410 | RSS: Main: 147529728 10:18:05 INFO - PROCESS | 9410 | 10:18:07 INFO - PROCESS | 9410 | Cycle 1(1): loaded http://localhost:40033/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40033/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:18:07 INFO - PROCESS | 9410 | RSS: Main: 147705856 10:18:07 INFO - PROCESS | 9410 | 10:18:11 INFO - PROCESS | 9410 | Cycle 1(1): loaded http://localhost:40033/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40033/tests/kraken/driver.html?testName=imaging-darkroom) 10:18:11 INFO - PROCESS | 9410 | RSS: Main: 147308544 10:18:11 INFO - PROCESS | 9410 | 10:18:15 INFO - PROCESS | 9410 | Cycle 1(1): loaded http://localhost:40033/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40033/tests/kraken/driver.html?testName=imaging-desaturate) 10:18:15 INFO - PROCESS | 9410 | RSS: Main: 146116608 10:18:15 INFO - PROCESS | 9410 | 10:18:18 INFO - PROCESS | 9410 | Cycle 1(1): loaded http://localhost:40033/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40033/tests/kraken/driver.html?testName=json-parse-financial) 10:18:19 INFO - PROCESS | 9410 | RSS: Main: 146436096 10:18:19 INFO - PROCESS | 9410 | 10:18:21 INFO - PROCESS | 9410 | Cycle 1(1): loaded http://localhost:40033/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40033/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:18:21 INFO - PROCESS | 9410 | RSS: Main: 147173376 10:18:21 INFO - PROCESS | 9410 | 10:18:23 INFO - PROCESS | 9410 | Cycle 1(1): loaded http://localhost:40033/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40033/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:18:24 INFO - PROCESS | 9410 | RSS: Main: 147587072 10:18:24 INFO - PROCESS | 9410 | 10:18:26 INFO - PROCESS | 9410 | Cycle 1(1): loaded http://localhost:40033/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40033/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:18:26 INFO - PROCESS | 9410 | RSS: Main: 147992576 10:18:26 INFO - PROCESS | 9410 | 10:18:29 INFO - PROCESS | 9410 | Cycle 1(1): loaded http://localhost:40033/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40033/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:18:30 INFO - PROCESS | 9410 | RSS: Main: 148369408 10:18:30 INFO - PROCESS | 9410 | 10:18:32 INFO - PROCESS | 9410 | Cycle 1(1): loaded http://localhost:40033/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40033/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:18:33 INFO - PROCESS | 9410 | RSS: Main: 148013056 10:18:33 INFO - PROCESS | 9410 | 10:18:35 INFO - PROCESS | 9410 | Cycle 1(1): loaded http://localhost:40033/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40033/tests/kraken/driver.html?testName=ai-astar) 10:18:35 INFO - PROCESS | 9410 | RSS: Main: 149184512 10:18:35 INFO - PROCESS | 9410 | 10:18:35 INFO - PROCESS | 9410 | __start_tp_report 10:18:35 INFO - PROCESS | 9410 | _x_x_mozilla_page_load 10:18:35 INFO - PROCESS | 9410 | _x_x_mozilla_page_load_details 10:18:35 INFO - PROCESS | 9410 | |i|pagename|runs| 10:18:35 INFO - PROCESS | 9410 | |0;ai-astar;118;110;115;115;115;126;116;113;114;114 10:18:35 INFO - PROCESS | 9410 | |1;audio-beat-detection;155;129;156;164;135;157;157;141;166;131 10:18:35 INFO - PROCESS | 9410 | |2;audio-dft;162;163;163;163;163;166;170;162;165;162 10:18:35 INFO - PROCESS | 9410 | |3;audio-fft;74;72;75;74;130;76;73;72;73;91 10:18:35 INFO - PROCESS | 9410 | |4;audio-oscillator;97;97;140;97;96;97;136;97;97;134 10:18:35 INFO - PROCESS | 9410 | |5;imaging-gaussian-blur;110;110;110;109;110;111;110;110;110;110 10:18:35 INFO - PROCESS | 9410 | |6;imaging-darkroom;147;147;148;148;148;150;149;148;149;148 10:18:35 INFO - PROCESS | 9410 | |7;imaging-desaturate;96;96;96;97;96;96;96;97;96;96 10:18:35 INFO - PROCESS | 9410 | |8;json-parse-financial;69;70;70;71;69;71;70;76;68;68 10:18:35 INFO - PROCESS | 9410 | |9;json-stringify-tinderbox;68;67;69;68;68;69;68;69;68;68 10:18:35 INFO - PROCESS | 9410 | |10;stanford-crypto-aes;84;84;86;85;84;84;95;85;93;84 10:18:35 INFO - PROCESS | 9410 | |11;stanford-crypto-ccm;126;122;132;124;121;124;127;142;124;137 10:18:35 INFO - PROCESS | 9410 | |12;stanford-crypto-pbkdf2;136;146;148;146;146;136;148;145;162;145 10:18:35 INFO - PROCESS | 9410 | |13;stanford-crypto-sha256-iterative;69;69;73;71;69;69;72;70;70;72 10:18:35 INFO - PROCESS | 9410 | __end_tp_report 10:18:35 INFO - PROCESS | 9410 | __start_cc_report 10:18:35 INFO - PROCESS | 9410 | _x_x_mozilla_cycle_collect,843 10:18:35 INFO - PROCESS | 9410 | __end_cc_report 10:18:35 INFO - PROCESS | 9410 | __startTimestamp1452622715450__endTimestamp 10:18:35 INFO - PROCESS | 9410 | 10:18:35 INFO - PROCESS | 9410 | ------- Summary: start ------- 10:18:35 INFO - PROCESS | 9410 | Number of tests: 14 10:18:35 INFO - PROCESS | 9410 | 10:18:35 INFO - PROCESS | 9410 | [#0] ai-astar Cycles:10 Average:115.60 Median:115.00 stddev:4.20 (3.6%) stddev-sans-first:4.36 10:18:35 INFO - PROCESS | 9410 | Values: 118.0 110.0 115.0 115.0 115.0 126.0 116.0 113.0 114.0 114.0 10:18:35 INFO - PROCESS | 9410 | 10:18:35 INFO - PROCESS | 9410 | [#1] audio-beat-detection Cycles:10 Average:149.10 Median:156.50 stddev:13.79 (8.8%) stddev-sans-first:14.46 10:18:35 INFO - PROCESS | 9410 | Values: 155.0 129.0 156.0 164.0 135.0 157.0 157.0 141.0 166.0 131.0 10:18:35 INFO - PROCESS | 9410 | 10:18:35 INFO - PROCESS | 9410 | [#2] audio-dft Cycles:10 Average:163.90 Median:163.00 stddev:2.51 (1.5%) stddev-sans-first:2.57 10:18:35 INFO - PROCESS | 9410 | Values: 162.0 163.0 163.0 163.0 163.0 166.0 170.0 162.0 165.0 162.0 10:18:35 INFO - PROCESS | 9410 | 10:18:35 INFO - PROCESS | 9410 | [#3] audio-fft Cycles:10 Average:81.00 Median:74.00 stddev:18.10 (24.5%) stddev-sans-first:19.02 10:18:35 INFO - PROCESS | 9410 | Values: 74.0 72.0 75.0 74.0 130.0 76.0 73.0 72.0 73.0 91.0 10:18:35 INFO - PROCESS | 9410 | 10:18:35 INFO - PROCESS | 9410 | [#4] audio-oscillator Cycles:10 Average:108.80 Median:97.00 stddev:19.29 (19.9%) stddev-sans-first:19.98 10:18:35 INFO - PROCESS | 9410 | Values: 97.0 97.0 140.0 97.0 96.0 97.0 136.0 97.0 97.0 134.0 10:18:35 INFO - PROCESS | 9410 | 10:18:35 INFO - PROCESS | 9410 | [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 10:18:35 INFO - PROCESS | 9410 | Values: 110.0 110.0 110.0 109.0 110.0 111.0 110.0 110.0 110.0 110.0 10:18:35 INFO - PROCESS | 9410 | 10:18:35 INFO - PROCESS | 9410 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:0.92 (0.6%) stddev-sans-first:0.87 10:18:35 INFO - PROCESS | 9410 | Values: 147.0 147.0 148.0 148.0 148.0 150.0 149.0 148.0 149.0 148.0 10:18:35 INFO - PROCESS | 9410 | 10:18:35 INFO - PROCESS | 9410 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 10:18:35 INFO - PROCESS | 9410 | Values: 96.0 96.0 96.0 97.0 96.0 96.0 96.0 97.0 96.0 96.0 10:18:35 INFO - PROCESS | 9410 | 10:18:35 INFO - PROCESS | 9410 | [#8] json-parse-financial Cycles:10 Average:70.20 Median:70.00 stddev:2.30 (3.3%) stddev-sans-first:2.40 10:18:35 INFO - PROCESS | 9410 | Values: 69.0 70.0 70.0 71.0 69.0 71.0 70.0 76.0 68.0 68.0 10:18:35 INFO - PROCESS | 9410 | 10:18:35 INFO - PROCESS | 9410 | [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.00 stddev:0.63 (0.9%) stddev-sans-first:0.67 10:18:35 INFO - PROCESS | 9410 | Values: 68.0 67.0 69.0 68.0 68.0 69.0 68.0 69.0 68.0 68.0 10:18:35 INFO - PROCESS | 9410 | 10:18:35 INFO - PROCESS | 9410 | [#10] stanford-crypto-aes Cycles:10 Average:86.40 Median:85.00 stddev:4.09 (4.8%) stddev-sans-first:4.24 10:18:35 INFO - PROCESS | 9410 | Values: 84.0 84.0 86.0 85.0 84.0 84.0 95.0 85.0 93.0 84.0 10:18:35 INFO - PROCESS | 9410 | 10:18:35 INFO - PROCESS | 9410 | [#11] stanford-crypto-ccm Cycles:10 Average:127.90 Median:126.50 stddev:6.92 (5.5%) stddev-sans-first:7.30 10:18:35 INFO - PROCESS | 9410 | Values: 126.0 122.0 132.0 124.0 121.0 124.0 127.0 142.0 124.0 137.0 10:18:35 INFO - PROCESS | 9410 | 10:18:35 INFO - PROCESS | 9410 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.80 Median:146.00 stddev:7.19 (4.9%) stddev-sans-first:6.70 10:18:35 INFO - PROCESS | 9410 | Values: 136.0 146.0 148.0 146.0 146.0 136.0 148.0 145.0 162.0 145.0 10:18:35 INFO - PROCESS | 9410 | 10:18:35 INFO - PROCESS | 9410 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:70.50 stddev:1.51 (2.1%) stddev-sans-first:1.51 10:18:35 INFO - PROCESS | 9410 | Values: 69.0 69.0 73.0 71.0 69.0 69.0 72.0 70.0 70.0 72.0 10:18:35 INFO - PROCESS | 9410 | -------- Summary: end -------- 10:18:35 INFO - PROCESS | 9410 | 10:18:36 INFO - TEST-INFO | 9410: exit 0 10:18:36 INFO - TEST-OK | kraken | took 62097ms 10:18:36 INFO - TEST-START | v8_7 10:18:36 INFO - operating with platform_type : linux_ 10:18:36 INFO - Initialising browser for v8_7 test... 10:18:36 INFO - TEST-INFO | started process 9696 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYJHvo7/profile http://localhost:40033/getInfo.html) 10:18:40 INFO - PROCESS | 9696 | 10:18:40 INFO - PROCESS | 9696 | (process:9767): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:18:41 INFO - PROCESS | 9696 | __metrics Screen width/height:1600/1200 10:18:41 INFO - PROCESS | 9696 | colorDepth:24 10:18:41 INFO - PROCESS | 9696 | Browser inner width/height: 1024/697 10:18:41 INFO - PROCESS | 9696 | __metrics 10:18:41 INFO - PROCESS | 9696 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:18:42 INFO - TEST-INFO | 9696: exit 0 10:18:42 INFO - Browser initialized. 10:18:42 INFO - Running cycle 1/1 for v8_7 test... 10:18:42 INFO - TEST-INFO | started process 9816 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYJHvo7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:18:43 INFO - PROCESS | 9816 | 10:18:43 INFO - PROCESS | 9816 | (process:9875): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:18:54 INFO - PROCESS | 9816 | RSS: Main: 149839872 10:18:54 INFO - PROCESS | 9816 | 10:19:16 INFO - PROCESS | 9816 | Cycle 1(1): loaded http://localhost:40033/tests/v8_7/run.html (next: http://localhost:40033/tests/v8_7/run.html) 10:19:16 INFO - PROCESS | 9816 | RSS: Main: 145494016 10:19:16 INFO - PROCESS | 9816 | 10:19:16 INFO - PROCESS | 9816 | __start_tp_report 10:19:16 INFO - PROCESS | 9816 | _x_x_mozilla_page_load 10:19:16 INFO - PROCESS | 9816 | _x_x_mozilla_page_load_details 10:19:16 INFO - PROCESS | 9816 | |i|pagename|runs| 10:19:16 INFO - PROCESS | 9816 | |0;Richards;165.31658125309968 10:19:16 INFO - PROCESS | 9816 | |1;DeltaBlue;186.67164457718872 10:19:16 INFO - PROCESS | 9816 | |2;Encrypt;279.2516056967328 10:19:16 INFO - PROCESS | 9816 | |3;Decrypt;5240.837696335078 10:19:16 INFO - PROCESS | 9816 | |4;RayTrace;1063.8297872340424 10:19:16 INFO - PROCESS | 9816 | |5;Earley;758.7253414264036 10:19:16 INFO - PROCESS | 9816 | |6;Boyer;12268.292682926829 10:19:16 INFO - PROCESS | 9816 | |7;RegExp;43574.46808510638 10:19:16 INFO - PROCESS | 9816 | |8;Splay;627.3525721455458 10:19:16 INFO - PROCESS | 9816 | |9;NavierStokes;4840.579710144928 10:19:16 INFO - PROCESS | 9816 | __end_tp_report 10:19:16 INFO - PROCESS | 9816 | __startTimestamp1452622756953__endTimestamp 10:19:16 INFO - PROCESS | 9816 | 10:19:16 INFO - PROCESS | 9816 | ------- Summary: start ------- 10:19:16 INFO - PROCESS | 9816 | Number of tests: 10 10:19:16 INFO - PROCESS | 9816 | 10:19:16 INFO - PROCESS | 9816 | [#0] Richards Cycles:1 Average:165.32 Median:165.32 stddev:0.00 (0.0%) 10:19:16 INFO - PROCESS | 9816 | Values: 165.3 10:19:16 INFO - PROCESS | 9816 | 10:19:16 INFO - PROCESS | 9816 | [#1] DeltaBlue Cycles:1 Average:186.67 Median:186.67 stddev:0.00 (0.0%) 10:19:16 INFO - PROCESS | 9816 | Values: 186.7 10:19:16 INFO - PROCESS | 9816 | 10:19:16 INFO - PROCESS | 9816 | [#2] Encrypt Cycles:1 Average:279.25 Median:279.25 stddev:0.00 (0.0%) 10:19:16 INFO - PROCESS | 9816 | Values: 279.3 10:19:16 INFO - PROCESS | 9816 | 10:19:16 INFO - PROCESS | 9816 | [#3] Decrypt Cycles:1 Average:5240.84 Median:5240.84 stddev:0.00 (0.0%) 10:19:16 INFO - PROCESS | 9816 | Values: 5240.8 10:19:16 INFO - PROCESS | 9816 | 10:19:16 INFO - PROCESS | 9816 | [#4] RayTrace Cycles:1 Average:1063.83 Median:1063.83 stddev:0.00 (0.0%) 10:19:16 INFO - PROCESS | 9816 | Values: 1063.8 10:19:16 INFO - PROCESS | 9816 | 10:19:16 INFO - PROCESS | 9816 | [#5] Earley Cycles:1 Average:758.73 Median:758.73 stddev:0.00 (0.0%) 10:19:16 INFO - PROCESS | 9816 | Values: 758.7 10:19:16 INFO - PROCESS | 9816 | 10:19:16 INFO - PROCESS | 9816 | [#6] Boyer Cycles:1 Average:12268.29 Median:12268.29 stddev:0.00 (0.0%) 10:19:16 INFO - PROCESS | 9816 | Values: 12268.3 10:19:16 INFO - PROCESS | 9816 | 10:19:16 INFO - PROCESS | 9816 | [#7] RegExp Cycles:1 Average:43574.47 Median:43574.47 stddev:0.00 (0.0%) 10:19:16 INFO - PROCESS | 9816 | Values: 43574.5 10:19:16 INFO - PROCESS | 9816 | 10:19:16 INFO - PROCESS | 9816 | [#8] Splay Cycles:1 Average:627.35 Median:627.35 stddev:0.00 (0.0%) 10:19:16 INFO - PROCESS | 9816 | Values: 627.4 10:19:16 INFO - PROCESS | 9816 | 10:19:16 INFO - PROCESS | 9816 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 10:19:16 INFO - PROCESS | 9816 | Values: 4840.6 10:19:16 INFO - PROCESS | 9816 | -------- Summary: end -------- 10:19:16 INFO - PROCESS | 9816 | 10:19:17 INFO - TEST-INFO | 9816: exit 0 10:19:17 INFO - TEST-OK | v8_7 | took 41469ms 10:19:17 INFO - SUITE-END | took 1217s 10:19:18 INFO - Completed test suite (00:20:18) 10:19:18 INFO - Working with test: dromaeo_css 10:19:18 INFO - Generating results file: dromaeo_css 10:19:18 INFO - Working with test: kraken 10:19:18 INFO - Generating results file: kraken 10:19:18 INFO - javascript benchmark 10:19:18 INFO - Working with test: v8_7 10:19:18 INFO - Generating results file: v8_7 10:19:18 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:19:18 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 10:19:18 INFO - process_Request line: dromaeo_css 6139.04 graph.html#tests=[[72,132,43]] 10:19:18 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:19:18 INFO - process_Request line: kraken 1541.70 graph.html#tests=[[232,132,43]] 10:19:18 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:19:18 INFO - process_Request line: v8_7 20090.10 graph.html#tests=[[230,132,43]] 10:19:18 INFO - RETURN: dromaeo_css: 6139.04 10:19:18 INFO - RETURN: kraken: 1541.70 10:19:18 INFO - RETURN: v8_7: 20090.10 10:19:18 INFO - javascript benchmark 10:19:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2605.8566778827158, 2615.8953641854323, 2642.8767773696172, 2651.42994256235, 2671.4122892963546, 4413.602775750186, 4444.444444444444, 4452.666050046243, 4459.821607135711, 4514.774261286939, 4444.888877778058, 4531.38826258455, 4543.4547854257535, 4544.863654090374, 4595.609373203273, 4201.39079833424, 4235.68232382571, 4240.21556012138, 4283.643995802312, 4291.9570804292025, 4077.612626800449, 4217.915641687165, 4245.617894389505, 4248.851290204843, 4261.105167914741, 4157.127003329305, 4169.708120431586, 4172.415861779354, 4213.115245798386, 4224.78876056196, 4194.475690538683, 4196.223698615766, 4209.6000879916355, 4212.4523811904255, 4258.850940217078, 4091.0386059276047, 4167.854125105637, 4181.498220213593, 4186.5604111568155, 4234.745915245096, 4449.17690227309, 4516.683832131752, 4521.208788462006, 4543.386642803245, 4557.293619488984, 4760.0, 4795.0409918016185, 4824.421069471686, 4829.3721816164025, 4874.0, 4689.88275293117, 4803.159447096779, 4818.156822556039, 4850.8059677612855, 4859.781309841065, 4502.054568540643, 4531.0, 4533.977330113361, 4555.362249285103, 4561.361409402686, 4954.925676114861, 4968.279599458058, 4972.378452693413, 4973.975130124326, 5011.5489605935645, 4620.44554653437, 4676.742779147179, 4751.049790042005, 4767.0, 4770.451398089194, 4811.230203167476, 4831.806727730922, 4832.4684284728655, 4861.27080937855, 4870.439899411542, 4766.666333356632, 4776.59398951093, 4781.187198176319, 4788.066327066258, 4830.855074347775, 4593.977030114828, 4698.765061746899, 4733.668643195012, 4764.499727528629, 4822.68652537584, 4053.3717273822604, 4065.308897487434, 4083.0404854859084, 4090.6727461802984, 4127.09203975125, 3584.1756396028536, 3599.8200089995394, 3606.4229723244157, 3622.239329740784, 3626.655467730561, 4081.551029386765, 4137.048478849882, 4194.559571245037, 4241.066965267636, 4268.807903644343, 4836.854894353175, 4880.365552478226, 4881.926771098437, 4913.754312284372, 4920.065187614414, 4059.89850253746, 4219.282721937278, 4225.345071513921, 4227.767472788964, 4268.338407546835, 4208.431861698631, 4306.41863348444, 4331.198728235287, 4334.26317526015, 4362.781860906942, 4641.74470404131, 4665.206914824488, 4669.089527542097, 4681.859544213679, 4705.717656940595, 4797.928031079467, 4871.8294859681155, 4902.828401005948, 4906.435759887516, 4912.066707325596, 4603.953960460352, 4646.3727396801, 4652.953470465387, 4660.300954856799, 4679.953200467951, 4830.372051633265, 4830.734309613005, 4834.0331933612715, 4842.564169224786, 4871.707697538159, 4776.928346074742, 4841.540053694894, 4857.854264371933, 4879.804807807648, 4919.532644398776, 4673.7896794645, 4697.271922851964, 4710.081534100817, 4735.905281894412, 4742.051589682008, 4678.274867395559, 4684.484706682194, 4692.976535117303, 4707.105649926503, 4733.810647574196, 4555.453345598549, 4556.726596404226, 4598.057398233287, 4616.653750968623, 4654.743989080633, 4740.597049250852, 4781.9043619128115, 4786.760661966958, 4807.6153907688, 4832.540908613676, 4639.930401043919, 4651.930221046619, 4654.767261636837, 4664.906701865876, 4683.578477936866], "unit": "score", "name": "dojo.html", "value": 4457.9830587057295}, {"lowerIsBetter": false, "replicates": [500.6645547483186, 506.7289000384794, 522.5662699959033, 532.1299675031322, 549.8158117030795, 32713.0, 33454.66545334543, 33490.33019339615, 33598.664013359856, 33638.32723345532, 37428.877133685965, 37947.6718314859, 38165.0, 38281.23437531248, 38317.0420739481, 7493.288137626931, 7710.768676939672, 7722.536647801122, 7737.226277372246, 7758.495697779655, 7452.962735186316, 7564.962175189116, 7628.275313845176, 7760.961195194016, 7793.337566306871, 7684.65419056141, 7879.4878332908465, 7883.605819709021, 7892.250236227549, 7903.209679032108, 7739.57432341221, 7797.610119494031, 7799.181085986003, 7808.336291415179, 7823.178566250575, 7464.178940316561, 7608.277213664693, 7610.809729756745, 7621.504602200839, 7675.19410461899, 36521.0, 36667.0, 36805.0, 36863.63136368629, 37030.22273329484, 2446.156076153724, 2804.3690169711654, 2922.0941508132546, 3022.531507616323, 3680.35593771089, 25969.74030259711, 26279.868600657064, 26355.34111647205, 26490.47019059608, 26671.0, 3277.311764529428, 3286.605607327112, 3300.5214243934734, 3375.426177549798, 3393.049946015095, 172451.0, 173795.0, 173955.0, 174213.0, 174453.12773436052, 46495.767521162175, 47924.04151916942, 49124.263136052985, 49241.26138107931, 54047.45952540503, 47741.5225847744, 47857.0, 48058.27912581314, 48107.518924811004, 48274.27588586174, 13018.414171362121, 13179.341032948507, 13196.20822750638, 13204.141730787467, 13205.075644704779, 10163.695089147337, 10227.539760710786, 10234.130098941525, 10243.436610986468, 10246.692599221886, 17820.5249976256, 18086.638267234583, 18575.44273671792, 18677.252909883726, 18742.718859217122, 7298.781036568806, 7486.7005319786595, 7529.548227106391, 7535.255945928473, 7552.282533159341, 830.1608498933541, 890.3856339125982, 897.7665806890125, 920.963161473547, 938.3337830140676, 25890.87054564753, 26897.0, 27041.864790676314, 27063.86468067647, 27297.181084567495, 931.3061768982017, 966.0918736387773, 992.0922356044283, 998.510729742421, 1074.8011617850566, 13538.93230533841, 14034.546422688562, 14448.349824257934, 14781.26093695311, 14900.70198596022, 258097.0, 265426.0, 267083.0, 267937.0, 267992.0, 38100.42849357262, 38165.236695265936, 38275.23449530994, 38332.0, 38421.423678644845, 1226.4113225651738, 1233.3031837012059, 1235.2897084176634, 1257.962181200495, 1262.211118051218, 23224.76775232226, 23745.287641370785, 23800.523989520458, 23815.52368952646, 25055.87472062628, 45534.316985244586, 46913.06173876435, 47084.0, 47201.291980621005, 47226.527734722215, 199553.0, 200338.0, 200849.0, 201079.0, 201134.0, 28316.575251371658, 28801.855990719912, 29011.0, 29138.417231654825, 29486.262843429085, 33221.33557328791, 33341.0, 33497.665023350426, 33716.662833372335, 34002.659973400936, 28554.0, 28841.278968025967, 28923.566146507397, 28935.56596651094, 29476.410471790015, 30342.696573033987, 30468.0, 31040.223994399417, 31372.843135784176, 31691.52462713015, 31467.52798708067, 32611.0, 33471.0, 33670.3265934675, 33882.49176262309, 25360.619590705785, 26817.463650726488, 27544.311392215353, 27693.0, 29271.85364073166, 23057.308280751604, 23099.76900230976, 23149.0, 23398.883005584863, 23457.296281111594], "unit": "score", "name": "ext.html", "value": 16023.831508606754}, {"lowerIsBetter": false, "replicates": [346.88649435312647, 350.0967503840093, 350.2749308930513, 350.72117666455165, 350.8070561191344, 14594.0, 14874.925625371872, 15269.847301526981, 16007.519774406757, 16439.753403698953, 14340.139591624484, 14435.133891966489, 15166.317515711791, 15197.772033419507, 15201.54395368138, 4335.34969754537, 4703.059388122372, 4726.763661816913, 4726.952730472703, 4733.148033354012, 4532.297493888436, 4580.473245576768, 4659.5573420525, 4659.813607455698, 4671.88320291992, 4810.0, 4999.900001999976, 5026.648134630577, 5032.874178145539, 5078.822241221558, 4872.65891387603, 4879.780409881546, 4883.731394773268, 4911.312416261726, 5666.5183459406, 5029.4216165141115, 5037.798488060474, 5043.84868453947, 5055.165897626887, 5057.140286151363, 11151.330920144817, 16073.276702548414, 17563.473095807145, 18360.724589131172, 18485.907570462197, 1807.358387772335, 1864.3754342295347, 1867.6918308479085, 1877.586930875219, 1890.3194849854042, 8512.1487851215, 8643.783905402352, 8673.13268673134, 8852.114788521161, 9112.772180695536, 1669.0569828047237, 1688.3415467967502, 1722.4402069327393, 1782.7236778299384, 1795.9942432237988, 49312.753436232946, 50957.490425095646, 51390.22914656283, 51527.0, 52051.73974130143, 9394.67118650844, 9643.27675424346, 9763.658271960589, 9769.413835169913, 9769.462679552551, 12502.249865008129, 12533.56132535375, 12540.310282934344, 12563.937180314222, 12565.74868502643, 6480.870382592322, 6497.9675101625135, 6566.80299591013, 6629.370209830058, 6841.897371539431, 6450.41946224842, 6460.773872914426, 6473.385028422293, 6499.350064993463, 6613.371729685672, 4132.442120313719, 4153.6677065834665, 4211.642010429086, 4224.471941007374, 4266.530681625019, 1695.2117265471616, 1795.5870149865605, 1819.1631849349183, 1820.8270214329618, 1826.5798866260834, 772.3628006894222, 836.0844874862138, 836.9497830130211, 850.268768858781, 870.6082262981683, 14470.927645361706, 14845.777313340308, 15174.924125379302, 15228.847711522743, 15338.693226135638, 838.5136620759945, 848.5036253791601, 880.124276345028, 902.5577467041103, 918.5956351891328, 8610.78473038179, 8836.646534138563, 8877.0, 8903.599338029804, 9037.0, 441678.0, 448915.0, 448998.0, 455871.0, 455965.0, 59122.40877591169, 62118.0, 63188.36811631825, 64950.67524662346, 65152.67423662851, 1032.8037672842286, 1035.3839465518004, 1043.2644985285356, 1045.4929359260752, 1049.5959055763585, 13572.253526056162, 13649.839763620204, 13753.862461375258, 13869.375878085712, 14164.291785410895, 30517.23706907345, 30794.692053079183, 30922.69077309288, 31001.8449907749, 31162.0, 39202.0, 39432.80283598564, 40077.0, 40109.197816042935, 41738.95652608709, 6627.701753421204, 6740.62926539045, 6822.624755638488, 6872.587644741331, 6997.510174287751, 9524.285678574273, 9694.418334899929, 9807.754806129904, 9921.851172232567, 10036.749081273027, 8057.798555036171, 8236.917630823615, 8284.46151000183, 8339.874901876598, 8674.522901240493, 8469.576521173793, 8794.20852123312, 9014.368994170607, 9082.36423450352, 9210.0, 2679.4105296834664, 3383.917146513092, 3553.911152221215, 8923.643054277756, 9233.492157931378, 6860.348266914635, 7132.108486439195, 7243.674034668347, 7261.455390845814, 7299.248195419322, 7858.253465920729, 9034.593443295198, 9054.275657947217, 9068.455892646462, 9126.406783559047], "unit": "score", "name": "jquery.html", "value": 7373.866127240271}, {"lowerIsBetter": false, "replicates": [1375.972480550389, 1419.5954153066375, 1545.6290490282336, 1725.6117373590935, 1751.6846967545844, 7260.056192694949, 7285.307895749908, 7461.477696561243, 7474.32731054205, 7499.775006749799, 7440.7767766966945, 7489.251074892508, 7504.81237969051, 7543.849123017536, 7545.7358992435275, 2175.7280339957506, 2226.0984301357894, 2226.6214743493647, 2226.977730222693, 2228.3426389215138, 2190.3210004898533, 2201.471646804763, 2218.057325636598, 2219.411855858191, 2221.4557433428754, 1795.9012254326008, 1839.2551016838202, 2053.887036213008, 2168.6746987951856, 2206.3491270075365, 2107.8735275883496, 2113.947151321214, 2121.2151503943564, 2121.374194612593, 2122.214780531198, 1973.2797528901847, 2002.5894691588335, 2011.2759406613607, 2020.2525065725629, 2021.1309137071053, 7114.928850711479, 7159.89260161098, 7161.641917904136, 7175.820604484878, 7182.066331376887, 4198.433211516437, 4296.183725092223, 4345.696291112685, 4350.303951367798, 4356.607905288539, 2621.9475610487684, 2626.3828000419885, 2657.2161212442184, 2717.877695503707, 2718.0486829609677, 866.4844417571597, 885.28292083412, 887.6094518411878, 895.6104094718818, 919.5310391700215, 10074.244431667581, 10139.695809125738, 10228.590856365736, 10243.539040743184, 10264.23018273625, 3850.403187505941, 3976.8210430530694, 4000.5399379071196, 4015.4579131817413, 4056.14820887611, 8260.421770476129, 8313.33493320533, 8318.126596707258, 8337.416380853403, 8350.665973360998, 4404.977975110168, 4415.845445409395, 4427.203103441347, 4431.202383570988, 4447.399601053881, 3997.8200980955926, 4000.979995100064, 4060.167665628539, 4063.227986682521, 4090.877273681794, 3104.9379012419627, 3175.841207939594, 3178.332550164445, 3182.5226216067776, 3208.422483952911, 932.2029664636638, 941.4492521874643, 944.2729098594044, 947.2611363136626, 958.8082383523323, 973.3478569358547, 978.3151793744265, 1018.9847152292722, 1035.6737627647267, 1188.417675339095, 6871.415929645936, 6901.102856628606, 6910.136232970879, 6921.204061532988, 6942.132233470817, 1028.7376718936623, 1043.415687215162, 1054.6256079091966, 1056.1128651932413, 1073.0771536478621, 5413.0, 5463.262459567907, 5482.0, 5497.835064948058, 5502.367227768777, 8775.868361974575, 8888.155625215593, 8971.416857904216, 9014.684486043088, 9071.27429805614, 8865.379423440427, 8976.640934362553, 9020.14308640678, 9028.729138125867, 9039.322050846213, 6648.800535983928, 6895.689693963684, 6950.20072691647, 7143.928410738431, 7143.999840022401, 6821.693023814039, 6875.724971001304, 6883.621400823003, 6896.27589103157, 6938.028675985265, 7801.258880406353, 7953.204679532232, 7962.562059086806, 7999.6400161994015, 8114.837703245784, 7764.883526747216, 7942.523448593103, 7954.125046244792, 7966.482178658369, 8065.798355040936, 6427.453666438405, 6451.290358060516, 6514.771982980573, 6518.087467754423, 6607.9669601651685, 6733.494987875831, 6835.282295359115, 6847.62338071391, 6849.794506164823, 6854.280300568568, 6557.9344206559235, 6698.765543205965, 6721.798346049626, 6744.932550674626, 6770.119884414995, 5602.439756024365, 5716.914246286392, 6195.287541932736, 6377.7130029147875, 6547.1161393211305, 6662.300458451987, 6700.095487109373, 6742.292059333699, 6744.494162937701, 6748.493862960199, 6088.299845517822, 6144.600600960924, 6157.692115394302, 6174.753009879554, 6195.008798592204, 6134.171886795226, 6173.104899789595, 6188.938110619017, 6189.907151392823, 6194.752209911553], "unit": "score", "name": "mootools.html", "value": 4176.956066266034}, {"lowerIsBetter": false, "replicates": [299.1877053798936, 300.0862374070953, 307.1767662664061, 312.6248501797842, 313.2372672542358, 5582.274304340435, 5625.859353516164, 5649.3220813502385, 5720.685362305072, 5771.5959882808165, 5575.219469274305, 5658.207850900877, 5684.772609095641, 5686.09022556391, 5707.828765137042, 4324.437823083011, 4326.805293761772, 4328.610425061744, 4329.588689074533, 4338.0, 4336.783160841946, 4337.893837071542, 4339.784860239122, 4342.934855977162, 4349.8695039148715, 3973.662238709713, 3974.165425260684, 4161.334186530155, 4235.915281694364, 4301.182775272689, 4177.937330940038, 4178.811953462102, 4180.623743863037, 4189.811458484375, 4208.684348673831, 3616.8734094306574, 3621.5835178954494, 3626.8367923443243, 3630.7640003399692, 3638.326909521747, 5397.487238712355, 5402.432744561804, 5403.351597808288, 5431.646942948696, 5434.673919564839, 4776.641751868624, 4867.294242334877, 4868.9756551217015, 4870.65905386623, 4922.114019476493, 5877.147813567009, 5887.4406931341455, 5898.056310990264, 5910.438508341701, 5913.822585322448, 4047.4131250968444, 4051.493563304587, 4054.7567145971334, 4055.1078762672164, 4062.5531191568903, 6160.552270216495, 6254.21822272216, 6261.96869015652, 6267.62394256346, 6270.498360131224, 4122.361034039729, 4159.9376009359885, 4178.603032711888, 4240.575942405735, 4256.5105012923295, 4286.249906266391, 4292.5063617683745, 4296.2481565725875, 4299.6775241856985, 4310.590493903074, 4885.0, 4890.217565189552, 4894.11905856942, 4903.411590609078, 4910.337104490919, 5806.419358064244, 5817.272840894888, 5905.793297234576, 5927.762889484458, 5929.199558059693, 1492.604459818149, 1508.6982603479128, 1540.892137550383, 1556.8323757182113, 1557.5249548887698, 1018.8420794776821, 1036.8652075230173, 1039.9688009359731, 1042.629866397418, 1055.171690223171, 5032.370953630796, 5076.822311219164, 5087.592992560661, 5097.490250974873, 5107.157319042391, 6084.5132389408745, 6088.238970128734, 6102.145699602059, 6118.60229085108, 6133.44798968095, 5063.291139240509, 5077.1876499759865, 5080.339555857789, 5083.415407228142, 5106.46382129871, 3203.9679603204136, 3261.673832616767, 3280.0815771583993, 3302.091924720721, 3313.950290745641, 5763.971180144073, 5765.106408506688, 5774.68239246837, 5781.335146458127, 5801.767929282782, 6288.213973253343, 6311.842203944938, 6320.747170113144, 6325.177726895474, 6334.968325158345, 5601.131824567198, 5780.335261444903, 5786.0, 5788.652680839163, 5793.2179155814265, 6113.388661134029, 6119.296280927572, 6128.63228206309, 6129.724162412613, 6132.5707200495535, 5919.940800591939, 5933.169356290036, 5947.553933454921, 5951.047832346804, 5955.970220148872, 5726.198332233407, 5757.798477053283, 5763.567732420169, 5764.740586673526, 5766.423357664368, 4013.618706222904, 4148.502179738451, 4149.356849688304, 4150.190712810973, 4342.761148136757, 5982.312034116132, 6088.695565221809, 6149.2313460817395, 6157.291911430064, 6205.162303089025, 5951.315598706205, 5970.5223582114195, 5986.2217911671205, 5987.790427335022, 5988.700564971821, 5927.614705044159, 5942.524598032061, 5975.9103613446705, 5985.551083668829, 5988.490978266722, 5693.146028095819, 5797.710114494343, 5852.151438041546, 5852.795152169653, 5861.35525092248, 6001.969990150022, 6018.849528761641, 6019.6990150493175, 6023.728932198149, 6040.728167232573, 5804.071348584206, 5817.592768506164, 5825.242718446575, 5840.123981402823, 5840.561957853093], "unit": "score", "name": "prototype.html", "value": 4409.656448860953}, {"lowerIsBetter": false, "replicates": [771.1555846348247, 782.170898847222, 787.9921200787998, 793.7618714385685, 798.4769975665937, 11487.0, 11605.883941160586, 11624.709382265448, 11628.476718547665, 11662.0, 11119.165337719287, 11226.831597526023, 11278.421021057058, 11312.151588630844, 11331.886681133186, 766.2605585609899, 775.0970119810414, 780.6135962698472, 781.663884529652, 781.9178986206451, 765.185077892046, 770.6146926536732, 771.2441807029115, 772.3589420780738, 773.2422226218309, 817.791463176889, 818.0510607695074, 819.5533434278333, 820.2658620534618, 821.9260266576007, 801.3669201330941, 808.2846680687634, 812.0296245986049, 812.2446125103651, 813.1868131868132, 599.6192417814675, 602.6745557399043, 602.8342205893414, 603.3604379357895, 604.1270364323555, 9244.676436324764, 9252.722418327461, 9275.58259878307, 9287.071292870727, 9321.300902432346, 9470.621175152986, 9656.951715241448, 9700.36947598411, 10058.04448577384, 10327.225458090597, 8355.373346998938, 8659.177378149128, 8683.739487815375, 8718.34612404066, 8798.164174403486, 3125.3280544683003, 3207.262329664167, 3208.2300247940325, 3228.3543291341825, 3259.0, 37978.81010594929, 39082.804585977174, 39101.60898391008, 39147.60852391468, 39442.21115577672, 9135.862962055575, 9149.222316103072, 9194.862077068849, 9272.350935434455, 9373.718788436357, 14736.0, 14769.630759231106, 14781.0, 14783.113013219241, 14793.630159246104, 6386.84032899172, 6472.644004579699, 6537.444317233088, 6553.803385898431, 6605.339466053452, 3543.3799085159994, 3543.698785603201, 3549.5563054618174, 3557.7153827693724, 3562.928741425157, 2601.245638764737, 2637.31429828246, 2640.4983053219826, 2643.4052338223746, 2646.801489888266, 480.6419217682779, 488.2456604545914, 489.59119135521524, 490.5682998960963, 498.14816663505087, 476.7044432451902, 574.2850151561333, 578.2713780636428, 596.4780816785313, 626.7023163997156, 7701.691932322757, 7914.287714105643, 8043.879341809878, 8073.677052917935, 8075.919240807634, 430.9310510318334, 474.8029567729354, 495.38077403245944, 508.80919655129327, 521.4707072321596, 2982.7017298270434, 3053.8167709937475, 3106.819408624708, 3112.8910488132806, 3375.5443015192636, 40515.39226911599, 40778.59221407748, 40898.79550602228, 41005.1798964025, 41143.7942810284, 39593.802030990235, 40619.7969010159, 42821.57178428238, 42875.78562107169, 43109.78445107755, 33928.0, 34355.0, 37272.25455490875, 38682.61317386846, 38949.22101558009, 7773.261540153676, 8232.464889782144, 8315.916840831514, 8474.449160804528, 8544.658213671384, 29339.41321173607, 29773.404531908807, 30072.3985520284, 30330.545041824833, 30687.693123068482, 35203.64796352004, 35206.0, 39281.017974550865, 39721.0, 40161.0, 10288.691339259834, 10422.270441069053, 10590.4704764763, 10623.415712135598, 10695.94652026735, 11146.219764616399, 11324.830127547928, 11345.886541134812, 11445.25605835618, 11823.822642660194, 10477.738056548647, 10496.68509944703, 10785.137189025016, 10947.50736216888, 11124.888751112385, 10400.167986560906, 10602.787944241227, 10674.146068314361, 11178.664640060812, 11215.0, 10843.67468975932, 10898.564057437614, 11291.774164516828, 11452.026577740986, 11454.541818327174, 8264.21489958453, 8736.25741811953, 8842.867356989778, 9205.815883682422, 9391.342606017513, 8482.703105391281, 8961.283097352327, 8987.775305617412, 9054.0, 9140.131687489678], "unit": "score", "name": "yui.html", "value": 5516.952260524758}], "name": "dromaeo_css", "value": 6139.042996909063}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [118.0, 110.0, 115.0, 115.0, 115.0, 126.0, 116.0, 113.0, 114.0, 114.0], "unit": "score", "name": "ai-astar", "value": 115.6}, {"lowerIsBetter": true, "replicates": [155.0, 129.0, 156.0, 164.0, 135.0, 157.0, 157.0, 141.0, 166.0, 131.0], "unit": "score", "name": "audio-beat-detection", "value": 149.1}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 163.0, 163.0, 163.0, 166.0, 170.0, 162.0, 165.0, 162.0], "unit": "score", "name": "audio-dft", "value": 163.9}, {"lowerIsBetter": true, "replicates": [74.0, 72.0, 75.0, 74.0, 130.0, 76.0, 73.0, 72.0, 73.0, 91.0], "unit": "score", "name": "audio-fft", "value": 81.0}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 140.0, 97.0, 96.0, 97.0, 136.0, 97.0, 97.0, 134.0], "unit": "score", "name": "audio-oscillator", "value": 108.8}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 109.0, 110.0, 111.0, 110.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 148.0, 148.0, 148.0, 150.0, 149.0, 148.0, 149.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 148.2}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 70.0, 71.0, 69.0, 71.0, 70.0, 76.0, 68.0, 68.0], "unit": "score", "name": "json-parse-financial", "value": 70.2}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 69.0, 68.0, 68.0, 69.0, 68.0, 69.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.2}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 86.0, 85.0, 84.0, 84.0, 95.0, 85.0, 93.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.4}, {"lowerIsBetter": true, "replicates": [126.0, 122.0, 132.0, 124.0, 121.0, 124.0, 127.0, 142.0, 124.0, 137.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 127.9}, {"lowerIsBetter": true, "replicates": [136.0, 146.0, 148.0, 146.0, 146.0, 136.0, 148.0, 145.0, 162.0, 145.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.8}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 73.0, 71.0, 69.0, 69.0, 72.0, 70.0, 70.0, 72.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.4}], "name": "kraken", "value": 1541.7000000000003}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.31658125309968], "unit": "score", "name": "Richards", "value": 213.54179800000009}, {"lowerIsBetter": false, "replicates": [186.67164457718872], "unit": "score", "name": "DeltaBlue", "value": 354.19412600000015}, {"lowerIsBetter": false, "replicates": [279.2516056967328], "unit": "score", "name": "Encrypt", "value": 953.1941609999996}, {"lowerIsBetter": false, "replicates": [5240.837696335078], "unit": "score", "name": "Decrypt", "value": 50.78978121878119}, {"lowerIsBetter": false, "replicates": [1063.8297872340424], "unit": "score", "name": "RayTrace", "value": 695.5896600000003}, {"lowerIsBetter": false, "replicates": [758.7253414264036], "unit": "score", "name": "Earley", "value": 878.3982340000001}, {"lowerIsBetter": false, "replicates": [12268.292682926829], "unit": "score", "name": "Boyer", "value": 54.32402186878729}, {"lowerIsBetter": false, "replicates": [43574.46808510638], "unit": "score", "name": "RegExp", "value": 20.906394042968756}, {"lowerIsBetter": false, "replicates": [627.3525721455458], "unit": "score", "name": "Splay", "value": 129.89665399999998}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 20090.102051000067}]} 10:19:18 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "20090.10"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1541.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6139.04"}}} 10:19:18 INFO - Return code: 0 10:19:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:19:18 INFO - # TBPL SUCCESS # 10:19:18 INFO - Running post-action listener: _resource_record_post_action 10:19:18 INFO - Running post-run listener: _resource_record_post_run 10:19:19 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 499712; Write bytes: 325312512; Read time: 208; Write time: 181248 10:19:19 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 14213120; Read time: 0; Write time: 1644 10:19:19 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 499712; Write bytes: 311099392; Read time: 208; Write time: 179604 10:19:19 INFO - Running post-run listener: _upload_blobber_files 10:19:19 INFO - Blob upload gear active. 10:19:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:19:19 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 10:19:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:19:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:19:20 INFO - (blobuploader) - INFO - Open directory for files ... 10:19:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:19:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:19:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:19:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:19:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:19:21 INFO - (blobuploader) - INFO - Done attempting. 10:19:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:19:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:19:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:19:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:19:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:19:21 INFO - (blobuploader) - INFO - Done attempting. 10:19:21 INFO - (blobuploader) - INFO - Iteration through files over. 10:19:21 INFO - Return code: 0 10:19:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:19:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:19:21 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4fbd702dfa40342a292e61c7f0a5eb9716e387931332927dd03c6aea4e56816dc42fc4b598f28f3d06ce5d5f37a63acb611be424439f2f49101468ff2ba7933a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dc2639de99472165617a5223b0532c439eb83e51f39778e7985ce11756278a86e19d479ed22b5be29ffd62a3272505c82b71b6a8721427aa55949cf831627a50"} 10:19:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:19:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:19:21 INFO - Contents: 10:19:21 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4fbd702dfa40342a292e61c7f0a5eb9716e387931332927dd03c6aea4e56816dc42fc4b598f28f3d06ce5d5f37a63acb611be424439f2f49101468ff2ba7933a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dc2639de99472165617a5223b0532c439eb83e51f39778e7985ce11756278a86e19d479ed22b5be29ffd62a3272505c82b71b6a8721427aa55949cf831627a50"} 10:19:21 INFO - Copying logs to upload dir... 10:19:21 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1315.388442 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 55 secs) (at 2016-01-12 10:19:21.942958) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-12 10:19:21.946522) ========= 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=6dbc10da6d83fee962c624be000001a8-1452620691.459913-160078361 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4fbd702dfa40342a292e61c7f0a5eb9716e387931332927dd03c6aea4e56816dc42fc4b598f28f3d06ce5d5f37a63acb611be424439f2f49101468ff2ba7933a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dc2639de99472165617a5223b0532c439eb83e51f39778e7985ce11756278a86e19d479ed22b5be29ffd62a3272505c82b71b6a8721427aa55949cf831627a50"} build_url:https://queue.taskcluster.net/v1/task/fsoeQ2wFRF63tLB3ZtkL0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011393 build_url: 'https://queue.taskcluster.net/v1/task/fsoeQ2wFRF63tLB3ZtkL0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4fbd702dfa40342a292e61c7f0a5eb9716e387931332927dd03c6aea4e56816dc42fc4b598f28f3d06ce5d5f37a63acb611be424439f2f49101468ff2ba7933a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dc2639de99472165617a5223b0532c439eb83e51f39778e7985ce11756278a86e19d479ed22b5be29ffd62a3272505c82b71b6a8721427aa55949cf831627a50"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-12 10:19:21.971047) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 10:19:21.971413) ========= 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=6dbc10da6d83fee962c624be000001a8-1452620691.459913-160078361 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004469 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 10:19:22.057192) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-12 10:19:22.057555) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-12 10:19:22.057885) ========= ========= Total master_lag: 0.22 =========