builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-036 starttime: 1447874915.43 results: success (0) buildid: 20151118110040 builduid: 9c6de3ea7cf74608abccc223c809d13a revision: 929982f95a788e798b848da372725dd80cc44b36 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 11:28:35.426757) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 11:28:35.427223) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 11:28:35.427524) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1447874161.778113-1850307875 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006472 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 11:28:35.462878) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 11:28:35.463224) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 11:28:35.539027) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 11:28:35.539302) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1447874161.778113-1850307875 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004663 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 11:28:35.610232) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 11:28:35.610500) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 11:28:35.610822) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 11:28:35.611109) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1447874161.778113-1850307875 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-18 11:28:35-- 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% 47.2M=0s 2015-11-18 11:28:35 (47.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.181561 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 11:28:35.808361) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 11:28:35.808664) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1447874161.778113-1850307875 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017377 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 11:28:35.858955) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 11:28:35.859322) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 929982f95a788e798b848da372725dd80cc44b36 --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 929982f95a788e798b848da372725dd80cc44b36 --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=9c54e757a4c805d85fea3bc7000001f2-1447874161.778113-1850307875 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-18 11:28:35,978 truncating revision to first 12 chars 2015-11-18 11:28:35,978 Setting DEBUG logging. 2015-11-18 11:28:35,978 attempt 1/10 2015-11-18 11:28:35,978 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/929982f95a78?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-18 11:28:36,486 unpacking tar archive at: fx-team-929982f95a78/testing/mozharness/ program finished with exit code 0 elapsedTime=0.792098 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 11:28:36.664452) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 11:28:36.664775) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 11:28:36.677153) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 11:28:36.677417) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 11:28:36.677810) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-11-18 11:28:36.678109) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--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=9c54e757a4c805d85fea3bc7000001f2-1447874161.778113-1850307875 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:28:36 INFO - MultiFileLogger online at 20151118 11:28:36 in /builds/slave/test 11:28:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 11:28:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:28:36 INFO - {'append_to_log': False, 11:28:36 INFO - 'base_work_dir': '/builds/slave/test', 11:28:36 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 11:28:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:28:36 INFO - 'branch': 'Fx-Team-Non-PGO', 11:28:36 INFO - 'buildbot_json_path': 'buildprops.json', 11:28:36 INFO - 'config_files': ('talos/linux_config.py',), 11:28:36 INFO - 'default_actions': ('clobber', 11:28:36 INFO - 'read-buildbot-config', 11:28:36 INFO - 'download-and-extract', 11:28:36 INFO - 'populate-webroot', 11:28:36 INFO - 'create-virtualenv', 11:28:36 INFO - 'install', 11:28:36 INFO - 'run-tests'), 11:28:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:28:36 INFO - 'download_minidump_stackwalk': True, 11:28:36 INFO - 'download_symbols': 'ondemand', 11:28:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:28:36 INFO - 'tooltool.py': '/tools/tooltool.py', 11:28:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:28:36 INFO - '/tools/misc-python/virtualenv.py')}, 11:28:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:28:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:28:36 INFO - 'installer_path': 'installer.exe', 11:28:36 INFO - 'log_level': 'info', 11:28:36 INFO - 'log_name': 'talos', 11:28:36 INFO - 'log_to_console': True, 11:28:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:28:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:28:36 INFO - 'opt_config_files': (), 11:28:36 INFO - 'pip_index': False, 11:28:36 INFO - 'sps_profile': False, 11:28:36 INFO - 'sps_profile_interval': 0, 11:28:36 INFO - 'suite': 'dromaeojs', 11:28:36 INFO - 'system_bits': '64', 11:28:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:28:36 INFO - 'title': 'talos-linux64-ix-036', 11:28:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:28:36 INFO - 'use_talos_json': True, 11:28:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:28:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:28:36 INFO - 'work_dir': 'build'} 11:28:36 INFO - ##### 11:28:36 INFO - ##### Running clobber step. 11:28:36 INFO - ##### 11:28:36 INFO - Running pre-action listener: _resource_record_pre_action 11:28:36 INFO - Running main action method: clobber 11:28:36 INFO - rmtree: /builds/slave/test/build 11:28:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:28:37 INFO - Running post-action listener: _resource_record_post_action 11:28:37 INFO - ##### 11:28:37 INFO - ##### Running read-buildbot-config step. 11:28:37 INFO - ##### 11:28:37 INFO - Running pre-action listener: _resource_record_pre_action 11:28:37 INFO - Running main action method: read_buildbot_config 11:28:37 INFO - Using buildbot properties: 11:28:37 INFO - { 11:28:37 INFO - "properties": { 11:28:37 INFO - "buildnumber": 2079, 11:28:37 INFO - "product": "firefox", 11:28:37 INFO - "script_repo_revision": "production", 11:28:37 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:28:37 INFO - "repository": "", 11:28:37 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 11:28:37 INFO - "buildid": "20151118110040", 11:28:37 INFO - "slavename": "talos-linux64-ix-036", 11:28:37 INFO - "pgo_build": "False", 11:28:37 INFO - "basedir": "/builds/slave/test", 11:28:37 INFO - "project": "", 11:28:37 INFO - "platform": "ubuntu64_hw", 11:28:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:28:37 INFO - "slavebuilddir": "test", 11:28:37 INFO - "scheduler": "tests-fx-team-linux64-talos", 11:28:37 INFO - "branch": "fx-team", 11:28:37 INFO - "repo_path": "integration/fx-team", 11:28:37 INFO - "stage_platform": "linux64", 11:28:37 INFO - "builduid": "9c6de3ea7cf74608abccc223c809d13a", 11:28:37 INFO - "revision": "929982f95a788e798b848da372725dd80cc44b36" 11:28:37 INFO - }, 11:28:37 INFO - "sourcestamp": { 11:28:37 INFO - "repository": "", 11:28:37 INFO - "hasPatch": false, 11:28:37 INFO - "project": "", 11:28:37 INFO - "branch": "fx-team-linux64-talos", 11:28:37 INFO - "changes": [ 11:28:37 INFO - { 11:28:37 INFO - "category": null, 11:28:37 INFO - "files": [ 11:28:37 INFO - { 11:28:37 INFO - "url": null, 11:28:37 INFO - "name": "https://queue.taskcluster.net/v1/task/fXTiJf9dSeSA50tLKrA_Ag/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 11:28:37 INFO - } 11:28:37 INFO - ], 11:28:37 INFO - "repository": "", 11:28:37 INFO - "rev": "929982f95a788e798b848da372725dd80cc44b36", 11:28:37 INFO - "who": "alessio.placitelli@gmail.com", 11:28:37 INFO - "when": 1447874841, 11:28:37 INFO - "number": 6678363, 11:28:37 INFO - "comments": "Bug 1221505 - Remove osfile.jsm dependency from TelemetrySession.jsm. r=dexter", 11:28:37 INFO - "project": "", 11:28:37 INFO - "at": "Wed 18 Nov 2015 11:27:21", 11:28:37 INFO - "branch": "fx-team-linux64-talos", 11:28:37 INFO - "revlink": "", 11:28:37 INFO - "properties": [ 11:28:37 INFO - [ 11:28:37 INFO - "buildid", 11:28:37 INFO - "20151118110040", 11:28:37 INFO - "Change" 11:28:37 INFO - ], 11:28:37 INFO - [ 11:28:37 INFO - "builduid", 11:28:37 INFO - "9c6de3ea7cf74608abccc223c809d13a", 11:28:37 INFO - "Change" 11:28:37 INFO - ], 11:28:37 INFO - [ 11:28:37 INFO - "pgo_build", 11:28:37 INFO - "False", 11:28:37 INFO - "Change" 11:28:37 INFO - ] 11:28:37 INFO - ], 11:28:37 INFO - "revision": "929982f95a788e798b848da372725dd80cc44b36" 11:28:37 INFO - } 11:28:37 INFO - ], 11:28:37 INFO - "revision": "929982f95a788e798b848da372725dd80cc44b36" 11:28:37 INFO - } 11:28:37 INFO - } 11:28:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/fXTiJf9dSeSA50tLKrA_Ag/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 11:28:37 INFO - Running post-action listener: _resource_record_post_action 11:28:37 INFO - ##### 11:28:37 INFO - ##### Running download-and-extract step. 11:28:37 INFO - ##### 11:28:37 INFO - Running pre-action listener: _resource_record_pre_action 11:28:37 INFO - Running main action method: download_and_extract 11:28:37 INFO - mkdir: /builds/slave/test/build/tests 11:28:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:28:37 INFO - https://queue.taskcluster.net/v1/task/fXTiJf9dSeSA50tLKrA_Ag/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:28:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXTiJf9dSeSA50tLKrA_Ag/artifacts/public/build/test_packages.json 11:28:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXTiJf9dSeSA50tLKrA_Ag/artifacts/public/build/test_packages.json 11:28:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXTiJf9dSeSA50tLKrA_Ag/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 11:28:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXTiJf9dSeSA50tLKrA_Ag/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 11:28:42 INFO - Downloaded 1302 bytes. 11:28:42 INFO - Reading from file /builds/slave/test/build/test_packages.json 11:28:42 INFO - Using the following test package requirements: 11:28:42 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 11:28:42 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:28:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:28:42 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:28:42 INFO - u'jsshell-linux-x86_64.zip'], 11:28:42 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:28:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:28:42 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 11:28:42 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:28:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:28:42 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:28:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:28:42 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:28:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:28:42 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 11:28:42 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:28:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:28:42 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:28:42 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')]} 11:28:42 INFO - https://queue.taskcluster.net/v1/task/fXTiJf9dSeSA50tLKrA_Ag/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:28:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXTiJf9dSeSA50tLKrA_Ag/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:28:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXTiJf9dSeSA50tLKrA_Ag/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:28:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXTiJf9dSeSA50tLKrA_Ag/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:28:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXTiJf9dSeSA50tLKrA_Ag/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:28:46 INFO - Downloaded 21291001 bytes. 11:28:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 11:28:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:28:46 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 11:28:47 INFO - Return code: 0 11:28:47 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:28:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:28:47 INFO - https://queue.taskcluster.net/v1/task/fXTiJf9dSeSA50tLKrA_Ag/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:28:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXTiJf9dSeSA50tLKrA_Ag/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:28:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXTiJf9dSeSA50tLKrA_Ag/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:28:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXTiJf9dSeSA50tLKrA_Ag/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:28:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXTiJf9dSeSA50tLKrA_Ag/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:28:54 INFO - Downloaded 21291001 bytes. 11:28:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 11:28:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:28:54 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 11:28:55 INFO - Return code: 0 11:28:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:28:55 INFO - https://queue.taskcluster.net/v1/task/fXTiJf9dSeSA50tLKrA_Ag/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:28:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXTiJf9dSeSA50tLKrA_Ag/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 11:28:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXTiJf9dSeSA50tLKrA_Ag/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 11:28:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXTiJf9dSeSA50tLKrA_Ag/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 11:28:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXTiJf9dSeSA50tLKrA_Ag/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:28:56 INFO - Downloaded 11130997 bytes. 11:28:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 11:28:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 11:28:56 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 11:28:57 INFO - Return code: 0 11:28:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:28:57 INFO - https://queue.taskcluster.net/v1/task/fXTiJf9dSeSA50tLKrA_Ag/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:28:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXTiJf9dSeSA50tLKrA_Ag/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 11:28:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXTiJf9dSeSA50tLKrA_Ag/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 11:28:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXTiJf9dSeSA50tLKrA_Ag/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 11:28:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXTiJf9dSeSA50tLKrA_Ag/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:28:59 INFO - Downloaded 55665228 bytes. 11:28:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fXTiJf9dSeSA50tLKrA_Ag/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 11:28:59 INFO - mkdir: /builds/slave/test/properties 11:28:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:28:59 INFO - Writing to file /builds/slave/test/properties/build_url 11:28:59 INFO - Contents: 11:28:59 INFO - build_url:https://queue.taskcluster.net/v1/task/fXTiJf9dSeSA50tLKrA_Ag/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 11:28:59 INFO - Running post-action listener: _resource_record_post_action 11:28:59 INFO - Running post-action listener: set_extra_try_arguments 11:28:59 INFO - ##### 11:28:59 INFO - ##### Running populate-webroot step. 11:28:59 INFO - ##### 11:28:59 INFO - Running pre-action listener: _resource_record_pre_action 11:28:59 INFO - Running main action method: populate_webroot 11:28:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:28:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:28:59 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 11:28:59 INFO - '../fennec_ids.txt'], 11:28:59 INFO - 'tests': ['tcheck2']}, 11:28:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:28:59 INFO - '--tppagecycles', 11:28:59 INFO - '7'], 11:28:59 INFO - 'tests': ['tsvgm']}}, 11:28:59 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:28:59 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:28:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:28:59 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:28:59 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:28:59 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:28:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:28:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:28:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:28:59 INFO - 'talos_options': ['--e10s'], 11:28:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:28:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:28:59 INFO - 'tests': ['damp', 'tps']}, 11:28:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:28:59 INFO - 'talos_options': ['--e10s'], 11:28:59 INFO - 'tests': ['damp', 'tps']}, 11:28:59 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:28:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:28:59 INFO - 'other': {'tests': ['a11yr', 11:28:59 INFO - 'ts_paint', 11:28:59 INFO - 'tpaint', 11:28:59 INFO - 'sessionrestore', 11:28:59 INFO - 'sessionrestore_no_auto_restore']}, 11:28:59 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:28:59 INFO - 'tests': ['a11yr', 11:28:59 INFO - 'ts_paint', 11:28:59 INFO - 'tpaint', 11:28:59 INFO - 'sessionrestore', 11:28:59 INFO - 'sessionrestore_no_auto_restore']}, 11:28:59 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:28:59 INFO - 'tests': ['a11yr', 11:28:59 INFO - 'ts_paint', 11:28:59 INFO - 'tpaint', 11:28:59 INFO - 'sessionrestore', 11:28:59 INFO - 'sessionrestore_no_auto_restore']}, 11:28:59 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:28:59 INFO - 'tests': ['a11yr', 11:28:59 INFO - 'ts_paint', 11:28:59 INFO - 'tpaint', 11:28:59 INFO - 'sessionrestore', 11:28:59 INFO - 'sessionrestore_no_auto_restore']}, 11:28:59 INFO - 'other_l64': {'tests': ['a11yr', 11:28:59 INFO - 'ts_paint', 11:28:59 INFO - 'tpaint', 11:28:59 INFO - 'sessionrestore', 11:28:59 INFO - 'sessionrestore_no_auto_restore']}, 11:28:59 INFO - 'other_nol64': {'tests': ['a11yr', 11:28:59 INFO - 'ts_paint', 11:28:59 INFO - 'tpaint', 11:28:59 INFO - 'sessionrestore', 11:28:59 INFO - 'sessionrestore_no_auto_restore']}, 11:28:59 INFO - 'svgr': {'tests': ['tsvgx', 11:28:59 INFO - 'tsvgr_opacity', 11:28:59 INFO - 'tart', 11:28:59 INFO - 'tscrollx', 11:28:59 INFO - 'cart']}, 11:28:59 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:28:59 INFO - 'tests': ['tsvgx', 11:28:59 INFO - 'tsvgr_opacity', 11:28:59 INFO - 'tart', 11:28:59 INFO - 'tscrollx', 11:28:59 INFO - 'cart']}, 11:28:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:28:59 INFO - 'tests': ['tp5o']}, 11:28:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:28:59 INFO - 'talos_options': ['--e10s'], 11:28:59 INFO - 'tests': ['tp5o']}, 11:28:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:28:59 INFO - 'talos_options': ['--xperf_path', 11:28:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:28:59 INFO - 'tests': ['tp5n']}, 11:28:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:28:59 INFO - 'talos_options': ['--e10s', 11:28:59 INFO - '--xperf_path', 11:28:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:28:59 INFO - 'tests': ['tp5n']}}, 11:28:59 INFO - 'talos.zip': {'path': '', 11:28:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:28:59 INFO - Running post-action listener: _resource_record_post_action 11:28:59 INFO - ##### 11:28:59 INFO - ##### Running create-virtualenv step. 11:28:59 INFO - ##### 11:28:59 INFO - Running pre-action listener: _resource_record_pre_action 11:28:59 INFO - Running main action method: create_virtualenv 11:28:59 INFO - Creating virtualenv /builds/slave/test/build/venv 11:28:59 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 11:28:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:28:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:28:59 INFO - Using real prefix '/usr' 11:28:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:28:59 INFO - Installing distribute.............................................................................................................................................................................................done. 11:29:01 INFO - Installing pip.................done. 11:29:01 INFO - Return code: 0 11:29:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:29:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:29:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:29:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:29:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:29:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:29:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:29:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f150aecac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfdb6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108c900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2b70>, '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 0x1123dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1124250>, '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': '9c54e757a4c805d85fea3bc7000001f2-1447874161.778113-1850307875', '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 11:29:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:29:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:29:01 INFO - Using env: {'DISPLAY': ':0', 11:29:01 INFO - 'HOME': '/home/cltbld', 11:29:01 INFO - 'LANG': 'en_US.UTF-8', 11:29:01 INFO - 'LANGUAGE': 'en_US:en', 11:29:01 INFO - 'LOGNAME': 'cltbld', 11:29:01 INFO - 'MAIL': '/var/mail/cltbld', 11:29:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:29:01 INFO - 'MOZ_NO_REMOTE': '1', 11:29:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:29:01 INFO - 'NO_EM_RESTART': '1', 11:29:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:29:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:29:01 INFO - 'PWD': '/builds/slave/test', 11:29:01 INFO - 'SHELL': '/bin/bash', 11:29:01 INFO - 'SHLVL': '1', 11:29:01 INFO - 'TERM': 'linux', 11:29:01 INFO - 'TMOUT': '86400', 11:29:01 INFO - 'USER': 'cltbld', 11:29:01 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1447874161.778113-1850307875', 11:29:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:29:01 INFO - '_': '/tools/buildbot/bin/python'} 11:29:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:29:01 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:29:01 INFO - Cleaning up... 11:29:02 INFO - Return code: 0 11:29:02 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:29:02 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')]} 11:29:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:29:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:29:02 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')]} 11:29:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:29:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:29:02 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 0x7f150aecac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfdb6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108c900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2b70>, '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 0x1123dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1124250>, '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': '9c54e757a4c805d85fea3bc7000001f2-1447874161.778113-1850307875', '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 11:29:02 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 11:29:02 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 11:29:02 INFO - Using env: {'DISPLAY': ':0', 11:29:02 INFO - 'HOME': '/home/cltbld', 11:29:02 INFO - 'LANG': 'en_US.UTF-8', 11:29:02 INFO - 'LANGUAGE': 'en_US:en', 11:29:02 INFO - 'LOGNAME': 'cltbld', 11:29:02 INFO - 'MAIL': '/var/mail/cltbld', 11:29:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:29:02 INFO - 'MOZ_NO_REMOTE': '1', 11:29:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:29:02 INFO - 'NO_EM_RESTART': '1', 11:29:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:29:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:29:02 INFO - 'PWD': '/builds/slave/test', 11:29:02 INFO - 'SHELL': '/bin/bash', 11:29:02 INFO - 'SHLVL': '1', 11:29:02 INFO - 'TERM': 'linux', 11:29:02 INFO - 'TMOUT': '86400', 11:29:02 INFO - 'USER': 'cltbld', 11:29:02 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1447874161.778113-1850307875', 11:29:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:29:02 INFO - '_': '/tools/buildbot/bin/python'} 11:29:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:29:02 INFO - Downloading/unpacking psutil>=0.7.1 11:29:02 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 11:29:02 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 11:29:02 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 11:29:02 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 11:29:02 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 11:29:02 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 11:29:03 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 11:29:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 11:29:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:29:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:29:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:29:04 INFO - Installing collected packages: psutil 11:29:04 INFO - Running setup.py install for psutil 11:29:04 INFO - building 'psutil._psutil_linux' extension 11:29:04 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 11:29:04 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 11:29:04 INFO - building 'psutil._psutil_posix' extension 11:29:04 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 11:29:04 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 11:29:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:29:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:29:04 INFO - Successfully installed psutil 11:29:04 INFO - Cleaning up... 11:29:04 INFO - Return code: 0 11:29:04 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:29:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:29:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:29:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:29:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:29:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:29:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:29:04 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 0x7f150aecac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfdb6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108c900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2b70>, '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 0x1123dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1124250>, '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': '9c54e757a4c805d85fea3bc7000001f2-1447874161.778113-1850307875', '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 11:29:04 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 11:29:04 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 11:29:04 INFO - Using env: {'DISPLAY': ':0', 11:29:04 INFO - 'HOME': '/home/cltbld', 11:29:04 INFO - 'LANG': 'en_US.UTF-8', 11:29:04 INFO - 'LANGUAGE': 'en_US:en', 11:29:04 INFO - 'LOGNAME': 'cltbld', 11:29:04 INFO - 'MAIL': '/var/mail/cltbld', 11:29:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:29:04 INFO - 'MOZ_NO_REMOTE': '1', 11:29:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:29:04 INFO - 'NO_EM_RESTART': '1', 11:29:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:29:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:29:04 INFO - 'PWD': '/builds/slave/test', 11:29:04 INFO - 'SHELL': '/bin/bash', 11:29:04 INFO - 'SHLVL': '1', 11:29:04 INFO - 'TERM': 'linux', 11:29:04 INFO - 'TMOUT': '86400', 11:29:04 INFO - 'USER': 'cltbld', 11:29:04 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1447874161.778113-1850307875', 11:29:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:29:04 INFO - '_': '/tools/buildbot/bin/python'} 11:29:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:29:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:29:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:29:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:29:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:29:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:29:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:29:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:29:06 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:29:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 11:29:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:29:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:29:06 INFO - Installing collected packages: mozsystemmonitor 11:29:06 INFO - Running setup.py install for mozsystemmonitor 11:29:06 INFO - Successfully installed mozsystemmonitor 11:29:06 INFO - Cleaning up... 11:29:06 INFO - Return code: 0 11:29:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:29:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:29:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:29:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:29:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:29:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:29:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:29:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f150aecac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfdb6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108c900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2b70>, '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 0x1123dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1124250>, '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': '9c54e757a4c805d85fea3bc7000001f2-1447874161.778113-1850307875', '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 11:29:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:29:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:29:06 INFO - Using env: {'DISPLAY': ':0', 11:29:06 INFO - 'HOME': '/home/cltbld', 11:29:06 INFO - 'LANG': 'en_US.UTF-8', 11:29:06 INFO - 'LANGUAGE': 'en_US:en', 11:29:06 INFO - 'LOGNAME': 'cltbld', 11:29:06 INFO - 'MAIL': '/var/mail/cltbld', 11:29:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:29:06 INFO - 'MOZ_NO_REMOTE': '1', 11:29:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:29:06 INFO - 'NO_EM_RESTART': '1', 11:29:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:29:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:29:06 INFO - 'PWD': '/builds/slave/test', 11:29:06 INFO - 'SHELL': '/bin/bash', 11:29:06 INFO - 'SHLVL': '1', 11:29:06 INFO - 'TERM': 'linux', 11:29:06 INFO - 'TMOUT': '86400', 11:29:06 INFO - 'USER': 'cltbld', 11:29:06 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1447874161.778113-1850307875', 11:29:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:29:06 INFO - '_': '/tools/buildbot/bin/python'} 11:29:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:29:06 INFO - Downloading/unpacking blobuploader==1.2.4 11:29:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:29:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:29:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:29:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:29:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:29:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:29:08 INFO - Downloading blobuploader-1.2.4.tar.gz 11:29:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 11:29:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:29:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:29:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:29:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:29:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:29:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:29:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:29:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:29:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 11:29:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:29:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:29:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:29:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:29:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:29:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:29:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:29:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:29:09 INFO - Downloading docopt-0.6.1.tar.gz 11:29:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 11:29:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:29:09 INFO - Installing collected packages: blobuploader, requests, docopt 11:29:09 INFO - Running setup.py install for blobuploader 11:29:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:29:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:29:09 INFO - Running setup.py install for requests 11:29:09 INFO - Running setup.py install for docopt 11:29:09 INFO - Successfully installed blobuploader requests docopt 11:29:09 INFO - Cleaning up... 11:29:09 INFO - Return code: 0 11:29:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:29:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:29:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:29:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:29:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:29:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:29:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:29:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f150aecac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfdb6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108c900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2b70>, '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 0x1123dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1124250>, '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': '9c54e757a4c805d85fea3bc7000001f2-1447874161.778113-1850307875', '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 11:29:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:29:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:29:09 INFO - Using env: {'DISPLAY': ':0', 11:29:09 INFO - 'HOME': '/home/cltbld', 11:29:09 INFO - 'LANG': 'en_US.UTF-8', 11:29:09 INFO - 'LANGUAGE': 'en_US:en', 11:29:09 INFO - 'LOGNAME': 'cltbld', 11:29:09 INFO - 'MAIL': '/var/mail/cltbld', 11:29:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:29:09 INFO - 'MOZ_NO_REMOTE': '1', 11:29:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:29:09 INFO - 'NO_EM_RESTART': '1', 11:29:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:29:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:29:09 INFO - 'PWD': '/builds/slave/test', 11:29:09 INFO - 'SHELL': '/bin/bash', 11:29:09 INFO - 'SHLVL': '1', 11:29:09 INFO - 'TERM': 'linux', 11:29:09 INFO - 'TMOUT': '86400', 11:29:09 INFO - 'USER': 'cltbld', 11:29:09 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1447874161.778113-1850307875', 11:29:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:29:09 INFO - '_': '/tools/buildbot/bin/python'} 11:29:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:29:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:29:10 INFO - Running setup.py (path:/tmp/pip-ubenP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:29:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:29:10 INFO - Running setup.py (path:/tmp/pip-Kd6jA0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:29:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:29:10 INFO - Running setup.py (path:/tmp/pip-vjnwdj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:29:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:29:10 INFO - Running setup.py (path:/tmp/pip-jomatj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:29:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:29:10 INFO - Running setup.py (path:/tmp/pip-BxO2_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:29:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:29:10 INFO - Running setup.py (path:/tmp/pip-fVZJ6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:29:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:29:10 INFO - Running setup.py (path:/tmp/pip-4aH5Ok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:29:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:29:10 INFO - Running setup.py (path:/tmp/pip-cjbz7G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:29:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:29:10 INFO - Running setup.py (path:/tmp/pip-HBTzrp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:29:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:29:10 INFO - Running setup.py (path:/tmp/pip-h66b0C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:29:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:29:10 INFO - Running setup.py (path:/tmp/pip-cc7GtK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:29:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:29:10 INFO - Running setup.py (path:/tmp/pip-zCdrfk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:29:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:29:10 INFO - Running setup.py (path:/tmp/pip-2nu2PM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:29:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:29:10 INFO - Running setup.py (path:/tmp/pip-6EaEx8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:29:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:29:11 INFO - Running setup.py (path:/tmp/pip-eumPNN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:29:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:29:11 INFO - Running setup.py (path:/tmp/pip-5kNHeP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:29:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:29:11 INFO - Running setup.py (path:/tmp/pip-F38pOx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:29:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:29:11 INFO - Running setup.py install for manifestparser 11:29:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:29:11 INFO - Running setup.py install for mozcrash 11:29:11 INFO - Running setup.py install for mozdebug 11:29:11 INFO - Running setup.py install for mozdevice 11:29:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:29:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:29:11 INFO - Running setup.py install for mozfile 11:29:11 INFO - Running setup.py install for mozhttpd 11:29:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:29:11 INFO - Running setup.py install for mozinfo 11:29:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:29:11 INFO - Running setup.py install for mozInstall 11:29:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:29:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:29:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:29:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:29:12 INFO - Running setup.py install for mozleak 11:29:12 INFO - Running setup.py install for mozlog 11:29:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:29:12 INFO - Running setup.py install for moznetwork 11:29:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:29:12 INFO - Running setup.py install for mozprocess 11:29:12 INFO - Running setup.py install for mozprofile 11:29:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:29:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:29:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:29:12 INFO - Running setup.py install for mozrunner 11:29:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:29:12 INFO - Running setup.py install for mozscreenshot 11:29:12 INFO - Running setup.py install for moztest 11:29:12 INFO - Running setup.py install for mozversion 11:29:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:29:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:29:13 INFO - Cleaning up... 11:29:13 INFO - Return code: 0 11:29:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:29:13 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')]} 11:29:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:29:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:29:13 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')]} 11:29:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:29:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:29:13 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 0x7f150aecac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfdb6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108c900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2b70>, '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 0x1123dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1124250>, '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': '9c54e757a4c805d85fea3bc7000001f2-1447874161.778113-1850307875', '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 11:29:13 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 11:29:13 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 11:29:13 INFO - Using env: {'DISPLAY': ':0', 11:29:13 INFO - 'HOME': '/home/cltbld', 11:29:13 INFO - 'LANG': 'en_US.UTF-8', 11:29:13 INFO - 'LANGUAGE': 'en_US:en', 11:29:13 INFO - 'LOGNAME': 'cltbld', 11:29:13 INFO - 'MAIL': '/var/mail/cltbld', 11:29:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:29:13 INFO - 'MOZ_NO_REMOTE': '1', 11:29:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:29:13 INFO - 'NO_EM_RESTART': '1', 11:29:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:29:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:29:13 INFO - 'PWD': '/builds/slave/test', 11:29:13 INFO - 'SHELL': '/bin/bash', 11:29:13 INFO - 'SHLVL': '1', 11:29:13 INFO - 'TERM': 'linux', 11:29:13 INFO - 'TMOUT': '86400', 11:29:13 INFO - 'USER': 'cltbld', 11:29:13 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1447874161.778113-1850307875', 11:29:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:29:13 INFO - '_': '/tools/buildbot/bin/python'} 11:29:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:29:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:29:13 INFO - Running setup.py (path:/tmp/pip-YDwziW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:29:13 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:29:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:29:13 INFO - Running setup.py (path:/tmp/pip-T_sdZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:29:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:29:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:29:13 INFO - Running setup.py (path:/tmp/pip-umLVkx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:29:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:29:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:29:13 INFO - Running setup.py (path:/tmp/pip-94zmQx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:29:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:29:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:29:13 INFO - Running setup.py (path:/tmp/pip-cj63iS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:29:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:29:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:29:13 INFO - Running setup.py (path:/tmp/pip-rcWY89-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:29:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:29:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:29:13 INFO - Running setup.py (path:/tmp/pip-uN82kc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:29:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:29:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:29:13 INFO - Running setup.py (path:/tmp/pip-UidLvH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:29:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:29:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:29:13 INFO - Running setup.py (path:/tmp/pip-UDX1dy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:29:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:29:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:29:13 INFO - Running setup.py (path:/tmp/pip-ly7Dhq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:29:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 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)) 11:29:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:29:13 INFO - Running setup.py (path:/tmp/pip-mbfVYk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:29:14 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)) 11:29:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:29:14 INFO - Running setup.py (path:/tmp/pip-kZAJdl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:29:14 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)) 11:29:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:29:14 INFO - Running setup.py (path:/tmp/pip-mnAr7h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:29:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 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)) 11:29:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:29:14 INFO - Running setup.py (path:/tmp/pip-uHIB1Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:29:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:29:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:29:14 INFO - Running setup.py (path:/tmp/pip-tYPZ7n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:29:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:29:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:29:14 INFO - Running setup.py (path:/tmp/pip-cb7P2V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:29:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:29:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:29:14 INFO - Running setup.py (path:/tmp/pip-sJysF8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:29:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:29:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:29:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:29:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:29:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:29:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:29:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:29:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:29:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:29:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:29:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:29:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:29:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:29:16 INFO - Downloading blessings-1.5.1.tar.gz 11:29:16 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 11:29:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:29:16 INFO - Installing collected packages: blessings 11:29:16 INFO - Running setup.py install for blessings 11:29:16 INFO - Successfully installed blessings 11:29:16 INFO - Cleaning up... 11:29:16 INFO - Return code: 0 11:29:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:29:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:29:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:29:16 INFO - Reading from file tmpfile_stdout 11:29:16 INFO - Current package versions: 11:29:16 INFO - argparse == 1.2.1 11:29:16 INFO - blessings == 1.5.1 11:29:16 INFO - blobuploader == 1.2.4 11:29:16 INFO - docopt == 0.6.1 11:29:16 INFO - manifestparser == 1.1 11:29:16 INFO - mozInstall == 1.12 11:29:16 INFO - mozcrash == 0.16 11:29:16 INFO - mozdebug == 0.1 11:29:16 INFO - mozdevice == 0.47 11:29:16 INFO - mozfile == 1.2 11:29:16 INFO - mozhttpd == 0.7 11:29:16 INFO - mozinfo == 0.9 11:29:16 INFO - mozleak == 0.1 11:29:16 INFO - mozlog == 3.0 11:29:16 INFO - moznetwork == 0.27 11:29:16 INFO - mozprocess == 0.22 11:29:16 INFO - mozprofile == 0.27 11:29:16 INFO - mozrunner == 6.11 11:29:16 INFO - mozscreenshot == 0.1 11:29:16 INFO - mozsystemmonitor == 0.0 11:29:16 INFO - moztest == 0.7 11:29:16 INFO - mozversion == 1.4 11:29:16 INFO - psutil == 3.1.1 11:29:16 INFO - requests == 1.2.3 11:29:16 INFO - wsgiref == 0.1.2 11:29:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:29:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:29:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:29:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:29:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:29:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:29:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:29:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f150aecac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfdb6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108c900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2b70>, '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 0x1123dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1124250>, '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': '9c54e757a4c805d85fea3bc7000001f2-1447874161.778113-1850307875', '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 11:29:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:29:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:29:16 INFO - Using env: {'DISPLAY': ':0', 11:29:16 INFO - 'HOME': '/home/cltbld', 11:29:16 INFO - 'LANG': 'en_US.UTF-8', 11:29:16 INFO - 'LANGUAGE': 'en_US:en', 11:29:16 INFO - 'LOGNAME': 'cltbld', 11:29:16 INFO - 'MAIL': '/var/mail/cltbld', 11:29:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:29:16 INFO - 'MOZ_NO_REMOTE': '1', 11:29:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:29:16 INFO - 'NO_EM_RESTART': '1', 11:29:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:29:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:29:16 INFO - 'PWD': '/builds/slave/test', 11:29:16 INFO - 'SHELL': '/bin/bash', 11:29:16 INFO - 'SHLVL': '1', 11:29:16 INFO - 'TERM': 'linux', 11:29:16 INFO - 'TMOUT': '86400', 11:29:16 INFO - 'USER': 'cltbld', 11:29:16 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1447874161.778113-1850307875', 11:29:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:29:16 INFO - '_': '/tools/buildbot/bin/python'} 11:29:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:29:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:29:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:29:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:29:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:29:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:29:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:29:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:29:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:29:16 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.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:29:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:29:16 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:29:16 INFO - Cleaning up... 11:29:16 INFO - Return code: 0 11:29:16 INFO - Running post-action listener: _resource_record_post_action 11:29:16 INFO - Running post-action listener: _start_resource_monitoring 11:29:16 INFO - Starting resource monitoring. 11:29:16 INFO - ##### 11:29:16 INFO - ##### Running install step. 11:29:16 INFO - ##### 11:29:16 INFO - Running pre-action listener: _resource_record_pre_action 11:29:16 INFO - Running main action method: install 11:29:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:29:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:29:17 INFO - Reading from file tmpfile_stdout 11:29:17 INFO - Detecting whether we're running mozinstall >=1.0... 11:29:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:29:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:29:17 INFO - Reading from file tmpfile_stdout 11:29:17 INFO - Output received: 11:29:17 INFO - Usage: mozinstall [options] installer 11:29:17 INFO - Options: 11:29:17 INFO - -h, --help show this help message and exit 11:29:17 INFO - -d DEST, --destination=DEST 11:29:17 INFO - Directory to install application into. [default: 11:29:17 INFO - "/builds/slave/test"] 11:29:17 INFO - --app=APP Application being installed. [default: firefox] 11:29:17 INFO - mkdir: /builds/slave/test/build/application 11:29:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:29:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:29:31 INFO - Reading from file tmpfile_stdout 11:29:31 INFO - Output received: 11:29:31 INFO - /builds/slave/test/build/application/firefox/firefox 11:29:31 INFO - Running post-action listener: _resource_record_post_action 11:29:31 INFO - ##### 11:29:31 INFO - ##### Running run-tests step. 11:29:31 INFO - ##### 11:29:31 INFO - Running pre-action listener: _resource_record_pre_action 11:29:31 INFO - Running main action method: run_tests 11:29:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:29:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:29:31 INFO - Python 2.7.3 11:29:31 INFO - Return code: 0 11:29:31 INFO - grabbing minidump binary from tooltool 11:29: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')]} 11:29:31 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 0x10d2b70>, '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 0x1123dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1124250>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:29:31 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 11:29:31 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 11:29:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:29:31 INFO - Return code: 0 11:29:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:29:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:29:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:29:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:29:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:29:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fXTiJf9dSeSA50tLKrA_Ag/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost'] in /builds/slave/test/build 11:29:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fXTiJf9dSeSA50tLKrA_Ag/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --webServer localhost 11:29:31 INFO - Using env: {'DISPLAY': ':0', 11:29:31 INFO - 'HOME': '/home/cltbld', 11:29:31 INFO - 'LANG': 'en_US.UTF-8', 11:29:31 INFO - 'LANGUAGE': 'en_US:en', 11:29:31 INFO - 'LOGNAME': 'cltbld', 11:29:31 INFO - 'MAIL': '/var/mail/cltbld', 11:29:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:29:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:29:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:29:31 INFO - 'MOZ_NO_REMOTE': '1', 11:29:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:29:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:29:31 INFO - 'NO_EM_RESTART': '1', 11:29:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:29:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:29:31 INFO - 'PWD': '/builds/slave/test', 11:29:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:29:31 INFO - 'SHELL': '/bin/bash', 11:29:31 INFO - 'SHLVL': '1', 11:29:31 INFO - 'TERM': 'linux', 11:29:31 INFO - 'TMOUT': '86400', 11:29:31 INFO - 'USER': 'cltbld', 11:29:31 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1447874161.778113-1850307875', 11:29:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:29:31 INFO - '_': '/tools/buildbot/bin/python'} 11:29:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fXTiJf9dSeSA50tLKrA_Ag/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost'] with output_timeout 3600 11:29:31 INFO - mozversion INFO | application_buildid: 20151118110040 11:29:31 INFO - mozversion INFO | application_changeset: 929982f95a788e798b848da372725dd80cc44b36 11:29:31 INFO - mozversion INFO | application_display_name: Nightly 11:29:31 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:29:31 INFO - mozversion INFO | application_name: Firefox 11:29:31 INFO - mozversion INFO | application_remotingname: firefox 11:29:31 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 11:29:31 INFO - mozversion INFO | application_vendor: Mozilla 11:29:31 INFO - mozversion INFO | application_version: 45.0a1 11:29:31 INFO - mozversion INFO | platform_buildid: 20151118110040 11:29:31 INFO - mozversion INFO | platform_changeset: 929982f95a788e798b848da372725dd80cc44b36 11:29:31 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 11:29:31 INFO - mozversion INFO | platform_version: 45.0a1 11:29:31 INFO - 2015-11-18 11:29:31,684 DEBUG : using testdate: 1447874971 11:29:31 INFO - 2015-11-18 11:29:31,684 DEBUG : actual date: 1447874971 11:29:31 INFO - 2015-11-18 11:29:31,757 INFO : starting webserver on 'localhost:42657' 11:29:31 INFO - 2015-11-18 11:29:31,757 INFO : Starting test suite talos-linux64-ix-036 11:29:31 INFO - 2015-11-18 11:29:31,757 INFO : Starting test dromaeo_css 11:29:31 INFO - 2015-11-18 11:29:31,758 DEBUG : operating with platform_type : linux_ 11:29:31 INFO - 2015-11-18 11:29:31,758 INFO : Initialising browser for dromaeo_css test... 11:29:31 INFO - 2015-11-18 11:29:31,765 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbpGDEo/profile http://localhost:42657/getInfo.html 11:29:37 INFO - 2015-11-18 11:29:37,199 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:29:37 INFO - 2015-11-18 11:29:37,199 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:29:37 INFO - 2015-11-18 11:29:37,199 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:29:37 INFO - 2015-11-18 11:29:37,199 DEBUG : BROWSER_OUTPUT: __metrics 11:29:37 INFO - 2015-11-18 11:29:37,368 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:29:38 INFO - 2015-11-18 11:29:38,801 INFO : Browser initialized. 11:29:38 INFO - 2015-11-18 11:29:38,802 INFO : Running cycle 1/1 for dromaeo_css test... 11:29:38 INFO - 2015-11-18 11:29:38,802 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbpGDEo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:29:50 INFO - 2015-11-18 11:29:50,791 DEBUG : BROWSER_OUTPUT: RSS: Main: 138297344 11:29:50 INFO - 2015-11-18 11:29:50,792 DEBUG : BROWSER_OUTPUT: 11:30:42 INFO - 2015-11-18 11:30:42,122 DEBUG : BROWSER_OUTPUT: 1447875042119 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] 11:32:54 INFO - 2015-11-18 11:32:54,057 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42657/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42657/tests/dromaeo/cssquery-ext.html) 11:32:55 INFO - 2015-11-18 11:32:55,169 DEBUG : BROWSER_OUTPUT: RSS: Main: 248639488 11:32:55 INFO - 2015-11-18 11:32:55,169 DEBUG : BROWSER_OUTPUT: 11:35:57 INFO - 2015-11-18 11:35:57,768 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42657/tests/dromaeo/cssquery-ext.html (next: http://localhost:42657/tests/dromaeo/cssquery-jquery.html) 11:35:58 INFO - 2015-11-18 11:35:58,340 DEBUG : BROWSER_OUTPUT: RSS: Main: 227545088 11:35:58 INFO - 2015-11-18 11:35:58,340 DEBUG : BROWSER_OUTPUT: 11:39:00 INFO - 2015-11-18 11:39:00,469 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42657/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42657/tests/dromaeo/cssquery-mootools.html) 11:39:01 INFO - 2015-11-18 11:39:01,035 DEBUG : BROWSER_OUTPUT: RSS: Main: 220631040 11:39:01 INFO - 2015-11-18 11:39:01,035 DEBUG : BROWSER_OUTPUT: 11:42:03 INFO - 2015-11-18 11:42:03,021 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42657/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42657/tests/dromaeo/cssquery-prototype.html) 11:42:03 INFO - 2015-11-18 11:42:03,607 DEBUG : BROWSER_OUTPUT: RSS: Main: 204673024 11:42:03 INFO - 2015-11-18 11:42:03,607 DEBUG : BROWSER_OUTPUT: 11:45:06 INFO - 2015-11-18 11:45:06,330 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42657/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42657/tests/dromaeo/cssquery-yui.html) 11:45:06 INFO - 2015-11-18 11:45:06,916 DEBUG : BROWSER_OUTPUT: RSS: Main: 210071552 11:45:06 INFO - 2015-11-18 11:45:06,916 DEBUG : BROWSER_OUTPUT: 11:48:09 INFO - 2015-11-18 11:48:09,505 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42657/tests/dromaeo/cssquery-yui.html (next: http://localhost:42657/tests/dromaeo/cssquery-dojo.html) 11:48:09 INFO - 2015-11-18 11:48:09,755 DEBUG : BROWSER_OUTPUT: RSS: Main: 251629568 11:48:09 INFO - 2015-11-18 11:48:09,755 DEBUG : BROWSER_OUTPUT: 11:48:09 INFO - 2015-11-18 11:48:09,757 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:48:09 INFO - 2015-11-18 11:48:09,757 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:48:09 INFO - 2015-11-18 11:48:09,757 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:48:09 INFO - 2015-11-18 11:48:09,757 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:48:09 INFO - 2015-11-18 11:48:09,759 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2655.907043253486;2737.8083534152615;2777.139086883065;2782.0541016054535;2793.441311737653;4518.2093133701555;4649.69776964497;4676.7427791471455;4741.976290118545;4773.832915847942;4604.76976151192;4669.836555720551;4682.41469816273;4682.484926658065;4694.882627934303;4321.243782338094;4331.675124365685;4404.735715857051;4467.10657868426;4477.6417886569;4176.477940257468;4418.977905110486;4436.64506839452;4484.66365022623;4522.050369422425;4272.380504826814;4290.42079319291;4366.628836548897;4382;4411.360352748866;4361.738295702268;4392.187445322594;4413.227685155085;4416.514183439819;4421.491528474235;4086.284900142493;4349.69552131351;4375.496817865923;4378.430803995492;4418.646508279362;4563.247064234397;4640;4754.429468463806;4762.285657151455;4781.474037855833;5139.203423469368;5143.3313669223135;5143.588512918957;5143.871403214912;5187.896242075138;4827.927581086286;4946.010797840447;5159.58723302135;5171.922421163648;5174.275601415805;4571.200039993021;4599.793009314555;4676.929846052312;4709.7174169549935;4762.499937506512;5114.130597798383;5118.360204974379;5121.487851214849;5148.304978827885;5157.9684063187515;4756.21522448799;4870.342503762017;4921.87695307613;4927.334809800631;4950.6782059166035;4938.481459446706;5072.467390923974;5204.687718736888;5217.2434996925995;5245.790168393221;5147.536721694991;5150.510701483353;5154;5158.871028224249;5205.505476979681;4749.905001899942;5144.6913185209005;5145.794168233228;5147.845564633067;5149.150390185578;4187.685923555746;4201.621854033152;4269.423627810268;4271.1671224111;4303.268444364466;3696.639872185342;3751.6060813614176;3772.1512659651357;3790.3556395412847;3804.4673745675627;4160.417541544186;4389.297712366006;4401.097774956126;4413.889652758707;4448.088141930896;4918.803247870117;4937.333459982929;5070.797168113234;5208.348956380452;5241.790328386822;4402.3396490526675;4403.581659742319;4410.404595379647;4414.668899832525;4457.2645513489915;4559.065391594715;4566.4063671723125;4580.885477863014;4586.243269860435;4617.215073437524;4608.723476591415;4707.693999889996;4714.151452738472;4725.692829966041;4869.147899117711;5115;5148.279240906201;5159.164659274028;5167.767450464663;5173.948260517497;4898.92651610219;4899.6570240084275;4899.877503062452;4903.705777653352;4910.091633047898;4798.4001999750035;4930.309756634002;4934.111859865258;4947.381577302837;5047.798088076436;5137.614678899023;5158.123119069692;5171.069207542528;5171.069207542679;5185;4997.3253610762085;5000.324956130876;5004.824831130893;5008.398992120969;5019.598432125495;4585.266357382803;4723.834665786681;4724.692894961954;4876.049170411736;5008.824691135938;4824.500069920224;4838.225883858566;4848.224284114524;4852.636052296021;4880.682755620874;4986.227134794112;4986.8753281168265;4987.650864439454;4988.925166122439;5025.698458092526;4481.843135490372;4600.470945841271;4609.124266389375;4684.6486513510945;4833.250846118857 11:48:09 INFO - 2015-11-18 11:48:09,762 DEBUG : BROWSER_OUTPUT: |1;ext.html;556.7049463784193;565.2933832709114;573.5640912906191;582.935877053524;584.9005669036266;27455.313617159554;27860.58209126862;27996.020139295128;28006.019789307404;35889.641103588954;39859.20281594367;40410.19179616406;40436.79781601095;40468.19063618733;40533.391999119965;8025.277725004763;8199.098099209083;8199.549024803633;8201.22088401601;8205;7297.927020729804;7461.888071678929;7940.2853743163105;10186.236032297571;10418.322809017389;9940.6520771773;10016.649417270397;10019.499025048755;10023.198144148488;10027.298089133763;7304.196538380774;10105.343152695088;10231.641892533726;10242.846357304683;10247.333923294962;7099.467539934474;10295.845562316572;10506.054455099078;10592.947035264775;10599.470026498644;37050.814745926094;37555.81222093899;37584;37597.43603845945;37598.43602345967;2803.5841899840652;2873.066253467631;2898.0146750104855;3070.723634872872;3387.779794313362;28600.998965036124;28754.568681469795;28923.71076289231;28931.710682893114;29357;3069.9539506907413;3135.18485193849;3165.0663054399006;3167.160702413862;3173.8571764270664;214123;214163;214526;215236.92381538148;215805.99999999843;44687.77656111699;46414;46583.30125048127;54752.45247547473;55319.72340138354;64815;66317.33682663208;66439;66480.33519664838;66496.33503664998;12823.679408014874;12940.547080852126;12956.157849739737;13040.54358097462;13041.347932603332;9306.90693093074;9320.161185493202;9321.906780932104;9324.067593240758;9565.713028609152;18735.531611709543;19014;19015.04924753757;19018.52453688669;19062.2375104997;7419.85160296791;7617.27635874591;7727.072751269883;7803.609819509002;7885.1326354101;784.2862994674819;800.6197056398164;838.6896848166217;848.6817443458702;973.1047436358567;26391.20826375212;26514.072007479645;26525.86737066302;26677.599836002475;26693.19920402391;851.9776268477851;917.7109210598641;921.2261700171754;1024.293237666008;1044.6291566493785;13904.443822246996;13919.582412527641;14013.5095271665;14079.366428510742;14121.223332716594;249718;253298;254938;255333;255942;45381.00808911017;45723.08553828905;45723.771381142884;45768.77115614467;45825;1128.7065363005677;1137.0846468592863;1142.5658249864998;1143.4740019591081;1162.3490845126755;25188.622170667088;25595.616065758655;26003.609945851207;26430.07494737675;26430.603540946515;35934.8203258982;36769.89690309295;40489;41581;42730.57269427266;203870;204852;205905;206028;206532;23969;27317.590236146076;27540.173794786187;27554;27563.862180688968;27739.167824964476;37962.810185948896;38530.61469385382;38531.2293754129;39250.214995700495;31963.520547192275;32214.35571288608;33283.50074748929;33590.83204583961;33618.32763344768;31413.685863141076;32752.34495310128;32918;33094;33121.171970700925;30712.539311910787;30811.075667730005;31102;33813.66186338203;34398;27128.593071104344;30063.549046764754;31897.39035864499;32556.674433255364;32899.177520562174;23086.191983280503;23230.419239519146;23473.53052938966;23554.528909421373;23559.293221203392 11:48:09 INFO - 2015-11-18 11:48:09,764 DEBUG : BROWSER_OUTPUT: |2;jquery.html;311.5778120646525;314.1048013162487;314.40734216002835;318.2965645922512;318.7577441144729;12499.812502812465;12910.806337904938;15433.382664693412;15544.689106217884;15886.523404297875;14810.777838332433;15287.963332004778;16274.83725162748;16503;16520.58698532537;4410.911781764363;4516.0967806438675;4520.909581808378;4521.389612402317;4858.344123543312;3092.087834088949;3161.9051428457183;4524.864254072367;6476.125723027378;6653.2681405045405;6143.8771224575485;6609.801705948805;6613.107230523866;6663.30035346289;6668.466522678174;6216.844578885519;6236.656983865885;6237.09562113491;6249.437550620421;6265.592736472115;6138.14066030756;6369.585976911532;6374.936250637481;6377.17096777416;6379.330170332095;20342.593148136955;21001.369958901105;21349.359519214293;21629;22329.441763955867;1976.160131943918;1977.2486455146952;1978.5350442645968;2006.8193862552293;2120.8833514156713;13542.119762215523;13637.181769093788;13765.449382024706;13957.860421395859;14062.367193476319;1868.0566314011473;1868.1780016792704;1889.9811001889943;1925.8459323254106;1927.5181204698824;57599.712001440144;57791;57828.42171578272;58076.41923580752;58873.705631471996;14619.415223391157;15284.541463756104;15305.234738263265;15375.692486150438;15387.769183462256;22242;22261.66607500889;22623.20818771335;22657.773422265895;22678.659820102712;7689.19263477338;7751.806204844924;7764.728234511765;7787.10448298453;7849.607519623996;6349.0476428536085;6355.142055822497;6389.137466442064;6390.8721825563225;6404.391582799627;5769.221155144086;7347.093353531533;7391.85216295671;7423.777286681408;7450.5529668219;999.8350272205005;1003.1272792670424;1008.8284991551454;1021.0351218098825;2053.2813515269536;384.51167017887127;396.6450027225617;398.06653397782156;399.21354930786305;408.9672826173899;8982.657638637094;9445.19715824149;9705.272104592184;10027.448490332956;10047.648332308334;409.63747083831026;410.9424680544726;417.38167180151527;430.4834198961259;434.12090516703927;5626.634268772516;5732.312122545238;5737.110747834093;5846.210761547221;5847.6783776891825;310840;316109;318728;439424;447089;61594.38405615976;62926.68536657288;63608.363916361166;63728.36271637317;65016.34983650198;459.2009902769224;473.3822361817861;473.6873663382151;475.707439924444;476.96422768291825;9643.710688679352;9666.95166524163;9719.562619682272;9812.803743924938;9876.654317098866;30393.544096838123;30770.911221333707;30975;32033.67966320307;32047.679523204468;39604;41240.38139427971;41276.793616031726;41422;41515;5715.771369145354;5773.624714393551;5847.473727364558;5848.327442344185;5861.677607731615;10595.15238780911;10604.946975265075;10658.307210031324;10762.46187690628;10791.514381852992;9019.458832470073;9115.453072815651;9339.719808405758;9369.484678342484;9381.812363752822;9085.2731781456;9202.723918282461;9275.907240927505;9373.718788436357;9412.95293523528;7962.163972783006;8909.331800115147;9259.72220833376;9351.438913665203;9828.459434731158;5788.131780232999;5846.824595262149;5851.678157701367;5896.380880007709;5922.763089476372;9061.77345566366;9153.359264851662;9393.812123757623;9424.952875235855;9468.431894086378 11:48:09 INFO - 2015-11-18 11:48:09,767 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1369.869862363075;1588.4202266172847;1642.3512712478564;1663.8668906487483;1667.7081510735618;5578.804741834037;6174.722137503812;6522.543421960465;6537.64042977636;6547.247066587344;6292;6406.071119687655;6409.839754006152;6412.679366031692;6414.71133798979;1644.9177541122956;1684.0400971446281;1932.3043704266454;1952.8047195280428;1979.9604007919834;1970.9310174143907;1974.042589344167;1976.1008741022872;1982.7620685517759;1984.3253293880077;1906.2470324221924;1931.5364312565023;1945.5233467800408;1948.5420926082359;1949.8342640875471;1972.339266345776;1983.97024044638;1990.3829812757947;1999.4401567561033;2015.2241387065937;1973.990130049355;1983.9008049597462;1992.6911328744068;1996.46095554201;2001.7297664815355;6635.369639884251;6708.12794336738;6728.192616885956;6729.125213722234;6729.6971636276485;3942.546607140187;3999.3800960851113;4021.8190181441905;4024.315866302706;4026.1545075534173;2283.0981762204;2647.1396796041363;2748.477789220042;2762.9723702762917;2766.5711814668557;772.8763397856316;844.6452489954172;860.1785295043219;868.5657171414293;902.6254104546671;8880.111988801133;9008.549572521348;9010.189082982562;9011.504367259799;9017.098290171061;3667.6332366763645;3667.9633203668154;3726.2361215950664;3733.962660373416;3744;7778.961105194438;7788.922110778933;7797.844043119106;7808.297253247235;7810.6875724971505;4106.466159399319;4111.075008123148;4120.546739858613;4127.628513433805;4132.979335103305;3784.810759462016;3785.6971442284553;3787.905302367408;3788.507494025759;3790.0903783092413;3275.1484614000055;3280.6227283862186;3286.3098749262444;3306.553615261957;3306.8181250031;1012.1093437774858;1012.6253286284121;1024.5031159887449;1033.2199189611795;1050.8476270940823;860.3461369359331;865.4115201662804;874.8512752832033;875.0112373018449;932.9737288982066;6542.411182993554;6576.5067619928695;6584.5061620378665;6585.835354116185;6587.242467116247;1004.8141093897652;1008.9243306752023;1029.8300780371305;1044.1594516414207;1063.5798859450474;5156.561692256125;5214.634975551675;5217.165253559412;5219.086659834514;5219.112750832368;6732.091167692397;7592.240775922474;7923.445358824943;7997.360211183091;8118.634661440249;7748.4188685848785;7808.258215469635;7825.217478252243;7913.920860791319;7930.246626570467;6215.471684906834;6303.180586523723;6331.9366806331345;6336.303006669263;6348.714307856158;6225.937740622536;6420.165378500765;6434.517411194272;6435.163428754232;6437;7086.078809754905;7111.679974401268;7273.98164257015;7360.374368178551;7390.113186417664;7084.752033678797;7338.046054012944;7514.436417268617;7526;7535.58554279498;6031.215941927521;6096.116063170904;6104.664243466652;6106.786262480792;6110.908336375047;6491.902621460587;6549.901751473827;6552.541322107407;6584.473242140713;6586.835329116619;5994.400559943971;6015.2781666200335;6069.787557435468;6119.3268740437625;6162.537809664203;6003.369646187262;6033.818985430444;6055.545834062551;6078.878422431439;6271.404216599416;6176.474999625082;6212.099245609271;6242.65665388408;6245.0320200369015;6264.4048815364295;5512.972435137799;5590.832275031756;5642.097264437671;5643.379228284967;5647.971760141173;5880.676562789087;5903.026000709835;5911.497522710618;5912.674802885883;5936.1095835625 11:48:09 INFO - 2015-11-18 11:48:09,767 DEBUG : BROWSER_OUTPUT: |4;prototype.html;272.47956403269757;276.2513588176043;280.58753632160716;281.0962754743499;286.046036468378;5189.065968125736;5216.113260745673;5323.281357016806;5330.093884039713;5330.973345133274;5166.948330516694;5318.787248510064;5365.248865158881;5367;5369.060414427469;4090.97954510227;4098.73358231714;4102.118044620406;4102.671786257092;4108.650764685005;3898.200868821885;3976.3439032559595;4097.221527909703;4103.158852435244;4107.116969851481;3960.069383694844;4051.513818341803;4072.1041370898356;4073.307537718595;4077.2864748669012;4023.7988100595;4068.613481719232;4074.6740260779065;4076.612721791425;4076.9796151019054;3546.556680414948;3549.432090865475;3550.6626870447267;3550.7336949728874;3553.502509648651;5164.070467315882;5178.430372659004;5182.170852663556;5182.32629758129;5184.11869982104;4586.770661466947;4694.906101877978;4706.599939005188;4718;4722.574968252874;5594.9720251398885;5601.327840659106;5616.32604087508;5616.971915140439;5622.212890195376;3619.8009109498967;3731.1791405890663;3867.9613203867884;3868.1683438060672;3871.7676939383446;5716;5893;5917.053271476543;5924.20023296858;5925.940740592625;3974.3243648579232;3975;3975.0658595230097;3975.5626881043063;3979.9602003980167;4040.717149799486;4043.251998380309;4045.110075783323;4045.8381664733083;4047.534533528682;4564.406627138451;4662.230731929194;4669.299605059268;4681.29780532916;4681.344611754357;5622.85942851432;5639.097744360883;5639.802606908821;5646.661200327993;5647.407022262685;1409.3235247081254;1413.321605629283;1416.4263473293333;1417.0576566583106;1417.0859795431888;949.6248981652209;955.2167222877313;959.5346257065457;975.7999610080059;979.0698836105586;4953.034158339161;4957.355543779286;4964.851054468371;4966.726830024311;4968.652194346433;5824.621399609012;5831.3877042910735;5833.766649334064;5837.153612726131;5841.7371218295275;4918.43438004634;4947.48051454592;4947.529984651453;4963.950360496421;4964.032013757354;3058.4189004089153;3115.5638210650527;3143.4184675835045;3149.779515433898;3151.11768704763;5536.086545719992;5555.916661250085;5557.749901254453;5562.777488900399;5563.638363506359;5949.077892926603;5990.520758339322;5993.9700301498215;6003.879922401527;6005.099235114681;5540.944590554042;5551.139573366135;5551.750171242304;5552.944470555404;5559.972200139055;5722.2561067061015;5897.5576831736935;5897.882042359043;5899.085641725539;5909.054551271776;5504.256925315031;5776.393478684846;5776.480116789509;5781.739821707949;5783.595148339576;5444.8094316698725;5504.779808807602;5591.217229587943;5592.804251851166;5597.860053498695;3802.372608519563;3840;3844.750091244172;3847.557530883872;3849.1147036182397;5797.072468405035;5853.502452291603;5854.707264636836;5855.414458554111;5864.06175011996;5424.376196737426;5605.355384130877;5607.327120745536;5623.718814059363;5625.915611265752;5556.249906262603;5557.749901254372;5561.582881283839;5564;5573.303337082864;5493.121100623881;5496.5053145217125;5496.945030549643;5498.890022199614;5516.862078447911;5530.695811730394;5662.178984047372;5670.489655930986;5682.886342273214;5687.3459552152035;5478.123500239943;5487.6981766003255;5493.983613031602;5506.862328441821;5511 11:48:09 INFO - 2015-11-18 11:48:09,771 DEBUG : BROWSER_OUTPUT: |5;yui.html;767.0756738130553;770.5415277909642;784.5410434895585;785.8428314337134;787.7991112266371;11763.882361176386;12047.939760301208;12058.155929084967;12066.215695979756;12071.155019148664;12027.398630068505;12090.758184836299;12097.395130243496;12112;12157.756844863097;608.1273372710153;619.7087368936615;778.1090651204396;781.9218078192177;795.2445177081767;783.2598194705977;784.6978913118462;789.498668345599;790.5888937752366;790.8774140008308;643.318082832197;829.5271695133777;834.9958250208771;835.106436113359;835.4235577451569;644.4232411991266;814.1939479914871;829.6847198064758;830.1325115254574;831.3847752663046;615.6244690738646;615.8768246350703;615.9014557670752;616.5191150902303;616.9660668663222;11763.235389699643;11945.04439644835;11954.342511161884;11968.34174120423;11977.461014254379;10951.45242737868;11642.534298628045;11689.76620467586;11945.522179112912;12117.151799374047;9056.728298151065;9084.454932703993;9112.908870911273;9146.2682985361;9222.631094756201;3239.0768630940306;3270.117068391521;3292.0946739646547;3325.068980685412;3345.5650765400587;39209.21581568353;39314.21371572553;39459.210815783525;39558;39801;7300.4159667226495;9737.269704772028;9744.171745401578;9750.902490974999;9797.608095676236;10647.361158330525;10721.088707459798;10722.142228621691;10760.461976901124;10763.892361076289;5621.494065534122;5624.887502250014;5628.690422026828;5794.884102318014;5885.205497257901;3525.383057964897;3538.6815186633326;3599.1002249437643;3621.5654121505063;3671.5564184855407;2484.5900426429434;2503.561876671575;2507.5611767940904;2508.4481414088873;2509.9749002510107;390.45141576085643;398.82053076115864;398.9281929252704;399.9660028897518;463.367503357914;526.5813678125899;587.6562211106465;590.1177739279805;601.5488383712216;605.6456972671036;7736.690532378754;7740.458167928191;7779.416543759241;7928.207179282141;8006.1993800619475;454.9112922979987;458.9609883159969;460.7903403951194;501.9046381187563;535.6325043308585;3496.9125771855397;3559.199180184438;3737.439384092408;3846.3076646203394;3894.4937158169255;45659.77170114128;46583;50238.24642630364;50503;50728;44118.558814412085;44670;45193.87015324643;45239.095218095455;45376.3193552097;41528;41736;41765.37351939723;42576.361354579705;43156.56843431589;8059.153788852086;8340.374471914509;8673.262772664395;8737.082606326498;8772.824543509221;32199.67800321967;32453;32866;33143.50284745779;33165;37269.254614908095;37322.813385932895;38242.808785955895;40830.38754418627;41146.58853411428;6912.205096413977;6994.755183568551;7206.783796486114;7241.601711905896;7595.392368610387;10614.150867930393;10843.186760993114;11287.943560282147;11518.308901465938;11602.94198529002;10272.486375681037;10387.94806025965;10465.47672616351;10483.37099774016;10641.414722190353;10404.323718958243;10758.300710453796;11009.394483303175;11076.280041797258;11201.047910927336;7605.505642133244;9994.850077248702;10328;10439.217058720475;10494.947525262325;9021.503817290111;9120.45277283365;9155.633774649206;9159.358844880795;9389.718308450758;9087.681931132378;9290.210332121846;9375.578098985425;9430.622775089194;9545.331826772059 11:48:09 INFO - 2015-11-18 11:48:09,771 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:48:09 INFO - 2015-11-18 11:48:09,771 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:48:09 INFO - 2015-11-18 11:48:09,771 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,915 11:48:09 INFO - 2015-11-18 11:48:09,771 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:48:09 INFO - 2015-11-18 11:48:09,771 DEBUG : BROWSER_OUTPUT: __startTimestamp1447876089756__endTimestamp 11:48:09 INFO - 2015-11-18 11:48:09,771 DEBUG : BROWSER_OUTPUT: 11:48:09 INFO - 2015-11-18 11:48:09,771 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:48:09 INFO - 2015-11-18 11:48:09,771 DEBUG : BROWSER_OUTPUT: Number of tests: 6 11:48:09 INFO - 2015-11-18 11:48:09,771 DEBUG : BROWSER_OUTPUT: 11:48:09 INFO - 2015-11-18 11:48:09,771 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4682.39 Median:4754.43 stddev:487.39 (10.3%) stddev-sans-first:462.23 11:48:09 INFO - 2015-11-18 11:48:09,772 DEBUG : BROWSER_OUTPUT: Values: 2655.9 2737.8 2777.1 2782.1 2793.4 4518.2 4649.7 4676.7 4742.0 4773.8 4604.8 4669.8 4682.4 4682.5 4694.9 4321.2 4331.7 4404.7 4467.1 4477.6 4176.5 4419.0 4436.6 4484.7 4522.1 4272.4 4290.4 4366.6 4382.0 4411.4 4361.7 4392.2 4413.2 4416.5 4421.5 4086.3 4349.7 4375.5 4378.4 4418.6 4563.2 4640.0 4754.4 4762.3 4781.5 5139.2 5143.3 5143.6 5143.9 5187.9 4827.9 4946.0 5159.6 5171.9 5174.3 4571.2 4599.8 4676.9 4709.7 4762.5 5114.1 5118.4 5121.5 5148.3 5158.0 4756.2 4870.3 4921.9 4927.3 4950.7 4938.5 5072.5 5204.7 5217.2 5245.8 5147.5 5150.5 5154.0 5158.9 5205.5 4749.9 5144.7 5145.8 5147.8 5149.2 4187.7 4201.6 4269.4 4271.2 4303.3 3696.6 3751.6 3772.2 3790.4 3804.5 4160.4 4389.3 4401.1 4413.9 4448.1 4918.8 4937.3 5070.8 5208.3 5241.8 4402.3 4403.6 4410.4 4414.7 4457.3 4559.1 4566.4 4580.9 4586.2 4617.2 4608.7 4707.7 4714.2 4725.7 4869.1 5115.0 5148.3 5159.2 5167.8 5173.9 4898.9 4899.7 4899.9 4903.7 4910.1 4798.4 4930.3 4934.1 4947.4 5047.8 5137.6 5158.1 5171.1 5171.1 5185.0 4997.3 5000.3 5004.8 5008.4 5019.6 4585.3 4723.8 4724.7 4876.0 5008.8 4824.5 4838.2 4848.2 4852.6 4880.7 4986.2 4986.9 4987.7 4988.9 5025.7 4481.8 4600.5 4609.1 4684.6 4833.3 11:48:09 INFO - 2015-11-18 11:48:09,772 DEBUG : BROWSER_OUTPUT: 11:48:09 INFO - 2015-11-18 11:48:09,772 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:38826.28 Median:17118.59 stddev:58667.63 (342.7%) stddev-sans-first:58761.84 11:48:09 INFO - 2015-11-18 11:48:09,772 DEBUG : BROWSER_OUTPUT: Values: 556.7 565.3 573.6 582.9 584.9 27455.3 27860.6 27996.0 28006.0 35889.6 39859.2 40410.2 40436.8 40468.2 40533.4 8025.3 8199.1 8199.5 8201.2 8205.0 7297.9 7461.9 7940.3 10186.2 10418.3 9940.7 10016.6 10019.5 10023.2 10027.3 7304.2 10105.3 10231.6 10242.8 10247.3 7099.5 10295.8 10506.1 10592.9 10599.5 37050.8 37555.8 37584.0 37597.4 37598.4 2803.6 2873.1 2898.0 3070.7 3387.8 28601.0 28754.6 28923.7 28931.7 29357.0 3070.0 3135.2 3165.1 3167.2 3173.9 214123.0 214163.0 214526.0 215236.9 215806.0 44687.8 46414.0 46583.3 54752.5 55319.7 64815.0 66317.3 66439.0 66480.3 66496.3 12823.7 12940.5 12956.2 13040.5 13041.3 9306.9 9320.2 9321.9 9324.1 9565.7 18735.5 19014.0 19015.0 19018.5 19062.2 7419.9 7617.3 7727.1 7803.6 7885.1 784.3 800.6 838.7 848.7 973.1 26391.2 26514.1 26525.9 26677.6 26693.2 852.0 917.7 921.2 1024.3 1044.6 13904.4 13919.6 14013.5 14079.4 14121.2 249718.0 253298.0 254938.0 255333.0 255942.0 45381.0 45723.1 45723.8 45768.8 45825.0 1128.7 1137.1 1142.6 1143.5 1162.3 25188.6 25595.6 26003.6 26430.1 26430.6 35934.8 36769.9 40489.0 41581.0 42730.6 203870.0 204852.0 205905.0 206028.0 206532.0 23969.0 27317.6 27540.2 27554.0 27563.9 27739.2 37962.8 38530.6 38531.2 39250.2 31963.5 32214.4 33283.5 33590.8 33618.3 31413.7 32752.3 32918.0 33094.0 33121.2 30712.5 30811.1 31102.0 33813.7 34398.0 27128.6 30063.5 31897.4 32556.7 32899.2 23086.2 23230.4 23473.5 23554.5 23559.3 11:48:09 INFO - 2015-11-18 11:48:09,772 DEBUG : BROWSER_OUTPUT: 11:48:09 INFO - 2015-11-18 11:48:09,772 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:22334.19 Median:474.70 stddev:61004.24 (12851.2%) stddev-sans-first:61152.96 11:48:09 INFO - 2015-11-18 11:48:09,772 DEBUG : BROWSER_OUTPUT: Values: 311.6 314.1 314.4 318.3 318.8 12499.8 12910.8 15433.4 15544.7 15886.5 14810.8 15288.0 16274.8 16503.0 16520.6 4410.9 4516.1 4520.9 4521.4 4858.3 3092.1 3161.9 4524.9 6476.1 6653.3 6143.9 6609.8 6613.1 6663.3 6668.5 6216.8 6236.7 6237.1 6249.4 6265.6 6138.1 6369.6 6374.9 6377.2 6379.3 20342.6 21001.4 21349.4 21629.0 22329.4 1976.2 1977.2 1978.5 2006.8 2120.9 13542.1 13637.2 13765.4 13957.9 14062.4 1868.1 1868.2 1890.0 1925.8 1927.5 57599.7 57791.0 57828.4 58076.4 58873.7 14619.4 15284.5 15305.2 15375.7 15387.8 22242.0 22261.7 22623.2 22657.8 22678.7 7689.2 7751.8 7764.7 7787.1 7849.6 6349.0 6355.1 6389.1 6390.9 6404.4 5769.2 7347.1 7391.9 7423.8 7450.6 999.8 1003.1 1008.8 1021.0 2053.3 384.5 396.6 398.1 399.2 409.0 8982.7 9445.2 9705.3 10027.4 10047.6 409.6 410.9 417.4 430.5 434.1 5626.6 5732.3 5737.1 5846.2 5847.7 310840.0 316109.0 318728.0 439424.0 447089.0 61594.4 62926.7 63608.4 63728.4 65016.3 459.2 473.4 473.7 475.7 477.0 9643.7 9667.0 9719.6 9812.8 9876.7 30393.5 30770.9 30975.0 32033.7 32047.7 39604.0 41240.4 41276.8 41422.0 41515.0 5715.8 5773.6 5847.5 5848.3 5861.7 10595.2 10604.9 10658.3 10762.5 10791.5 9019.5 9115.5 9339.7 9369.5 9381.8 9085.3 9202.7 9275.9 9373.7 9413.0 7962.2 8909.3 9259.7 9351.4 9828.5 5788.1 5846.8 5851.7 5896.4 5922.8 9061.8 9153.4 9393.8 9425.0 9468.4 11:48:09 INFO - 2015-11-18 11:48:09,772 DEBUG : BROWSER_OUTPUT: 11:48:09 INFO - 2015-11-18 11:48:09,772 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4722.14 Median:6044.68 stddev:2399.76 (39.7%) stddev-sans-first:2393.27 11:48:09 INFO - 2015-11-18 11:48:09,772 DEBUG : BROWSER_OUTPUT: Values: 1369.9 1588.4 1642.4 1663.9 1667.7 5578.8 6174.7 6522.5 6537.6 6547.2 6292.0 6406.1 6409.8 6412.7 6414.7 1644.9 1684.0 1932.3 1952.8 1980.0 1970.9 1974.0 1976.1 1982.8 1984.3 1906.2 1931.5 1945.5 1948.5 1949.8 1972.3 1984.0 1990.4 1999.4 2015.2 1974.0 1983.9 1992.7 1996.5 2001.7 6635.4 6708.1 6728.2 6729.1 6729.7 3942.5 3999.4 4021.8 4024.3 4026.2 2283.1 2647.1 2748.5 2763.0 2766.6 772.9 844.6 860.2 868.6 902.6 8880.1 9008.5 9010.2 9011.5 9017.1 3667.6 3668.0 3726.2 3734.0 3744.0 7779.0 7788.9 7797.8 7808.3 7810.7 4106.5 4111.1 4120.5 4127.6 4133.0 3784.8 3785.7 3787.9 3788.5 3790.1 3275.1 3280.6 3286.3 3306.6 3306.8 1012.1 1012.6 1024.5 1033.2 1050.8 860.3 865.4 874.9 875.0 933.0 6542.4 6576.5 6584.5 6585.8 6587.2 1004.8 1008.9 1029.8 1044.2 1063.6 5156.6 5214.6 5217.2 5219.1 5219.1 6732.1 7592.2 7923.4 7997.4 8118.6 7748.4 7808.3 7825.2 7913.9 7930.2 6215.5 6303.2 6331.9 6336.3 6348.7 6225.9 6420.2 6434.5 6435.2 6437.0 7086.1 7111.7 7274.0 7360.4 7390.1 7084.8 7338.0 7514.4 7526.0 7535.6 6031.2 6096.1 6104.7 6106.8 6110.9 6491.9 6549.9 6552.5 6584.5 6586.8 5994.4 6015.3 6069.8 6119.3 6162.5 6003.4 6033.8 6055.5 6078.9 6271.4 6176.5 6212.1 6242.7 6245.0 6264.4 5513.0 5590.8 5642.1 5643.4 5648.0 5880.7 5903.0 5911.5 5912.7 5936.1 11:48:09 INFO - 2015-11-18 11:48:09,772 DEBUG : BROWSER_OUTPUT: 11:48:09 INFO - 2015-11-18 11:48:09,773 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4640.76 Median:5330.53 stddev:1387.23 (26.0%) stddev-sans-first:1351.82 11:48:09 INFO - 2015-11-18 11:48:09,773 DEBUG : BROWSER_OUTPUT: Values: 272.5 276.3 280.6 281.1 286.0 5189.1 5216.1 5323.3 5330.1 5331.0 5166.9 5318.8 5365.2 5367.0 5369.1 4091.0 4098.7 4102.1 4102.7 4108.7 3898.2 3976.3 4097.2 4103.2 4107.1 3960.1 4051.5 4072.1 4073.3 4077.3 4023.8 4068.6 4074.7 4076.6 4077.0 3546.6 3549.4 3550.7 3550.7 3553.5 5164.1 5178.4 5182.2 5182.3 5184.1 4586.8 4694.9 4706.6 4718.0 4722.6 5595.0 5601.3 5616.3 5617.0 5622.2 3619.8 3731.2 3868.0 3868.2 3871.8 5716.0 5893.0 5917.1 5924.2 5925.9 3974.3 3975.0 3975.1 3975.6 3980.0 4040.7 4043.3 4045.1 4045.8 4047.5 4564.4 4662.2 4669.3 4681.3 4681.3 5622.9 5639.1 5639.8 5646.7 5647.4 1409.3 1413.3 1416.4 1417.1 1417.1 949.6 955.2 959.5 975.8 979.1 4953.0 4957.4 4964.9 4966.7 4968.7 5824.6 5831.4 5833.8 5837.2 5841.7 4918.4 4947.5 4947.5 4964.0 4964.0 3058.4 3115.6 3143.4 3149.8 3151.1 5536.1 5555.9 5557.7 5562.8 5563.6 5949.1 5990.5 5994.0 6003.9 6005.1 5540.9 5551.1 5551.8 5552.9 5560.0 5722.3 5897.6 5897.9 5899.1 5909.1 5504.3 5776.4 5776.5 5781.7 5783.6 5444.8 5504.8 5591.2 5592.8 5597.9 3802.4 3840.0 3844.8 3847.6 3849.1 5797.1 5853.5 5854.7 5855.4 5864.1 5424.4 5605.4 5607.3 5623.7 5625.9 5556.2 5557.7 5561.6 5564.0 5573.3 5493.1 5496.5 5496.9 5498.9 5516.9 5530.7 5662.2 5670.5 5682.9 5687.3 5478.1 5487.7 5494.0 5506.9 5511.0 11:48:09 INFO - 2015-11-18 11:48:09,773 DEBUG : BROWSER_OUTPUT: 11:48:09 INFO - 2015-11-18 11:48:09,773 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12025.74 Median:45307.71 stddev:13845.95 (30.6%) stddev-sans-first:13858.97 11:48:09 INFO - 2015-11-18 11:48:09,774 DEBUG : BROWSER_OUTPUT: Values: 767.1 770.5 784.5 785.8 787.8 11763.9 12047.9 12058.2 12066.2 12071.2 12027.4 12090.8 12097.4 12112.0 12157.8 608.1 619.7 778.1 781.9 795.2 783.3 784.7 789.5 790.6 790.9 643.3 829.5 835.0 835.1 835.4 644.4 814.2 829.7 830.1 831.4 615.6 615.9 615.9 616.5 617.0 11763.2 11945.0 11954.3 11968.3 11977.5 10951.5 11642.5 11689.8 11945.5 12117.2 9056.7 9084.5 9112.9 9146.3 9222.6 3239.1 3270.1 3292.1 3325.1 3345.6 39209.2 39314.2 39459.2 39558.0 39801.0 7300.4 9737.3 9744.2 9750.9 9797.6 10647.4 10721.1 10722.1 10760.5 10763.9 5621.5 5624.9 5628.7 5794.9 5885.2 3525.4 3538.7 3599.1 3621.6 3671.6 2484.6 2503.6 2507.6 2508.4 2510.0 390.5 398.8 398.9 400.0 463.4 526.6 587.7 590.1 601.5 605.6 7736.7 7740.5 7779.4 7928.2 8006.2 454.9 459.0 460.8 501.9 535.6 3496.9 3559.2 3737.4 3846.3 3894.5 45659.8 46583.0 50238.2 50503.0 50728.0 44118.6 44670.0 45193.9 45239.1 45376.3 41528.0 41736.0 41765.4 42576.4 43156.6 8059.2 8340.4 8673.3 8737.1 8772.8 32199.7 32453.0 32866.0 33143.5 33165.0 37269.3 37322.8 38242.8 40830.4 41146.6 6912.2 6994.8 7206.8 7241.6 7595.4 10614.2 10843.2 11287.9 11518.3 11602.9 10272.5 10387.9 10465.5 10483.4 10641.4 10404.3 10758.3 11009.4 11076.3 11201.0 7605.5 9994.9 10328.0 10439.2 10494.9 9021.5 9120.5 9155.6 9159.4 9389.7 9087.7 9290.2 9375.6 9430.6 9545.3 11:48:09 INFO - 2015-11-18 11:48:09,774 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:48:09 INFO - 2015-11-18 11:48:09,774 DEBUG : BROWSER_OUTPUT: 11:48:10 INFO - 2015-11-18 11:48:10,585 INFO : Browser exited with error code: 0 11:48:10 INFO - 2015-11-18 11:48:10,604 INFO : Completed test dromaeo_css (00:18:38) 11:48:10 INFO - 2015-11-18 11:48:10,604 INFO : Starting test kraken 11:48:10 INFO - 2015-11-18 11:48:10,604 DEBUG : operating with platform_type : linux_ 11:48:10 INFO - 2015-11-18 11:48:10,604 INFO : Initialising browser for kraken test... 11:48:10 INFO - 2015-11-18 11:48:10,611 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRj4YZg/profile http://localhost:42657/getInfo.html 11:48:15 INFO - 2015-11-18 11:48:15,077 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:48:15 INFO - 2015-11-18 11:48:15,078 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:48:15 INFO - 2015-11-18 11:48:15,078 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:48:15 INFO - 2015-11-18 11:48:15,078 DEBUG : BROWSER_OUTPUT: __metrics 11:48:15 INFO - 2015-11-18 11:48:15,255 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:48:16 INFO - 2015-11-18 11:48:16,532 INFO : Browser initialized. 11:48:16 INFO - 2015-11-18 11:48:16,532 INFO : Running cycle 1/1 for kraken test... 11:48:16 INFO - 2015-11-18 11:48:16,532 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRj4YZg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:48:28 INFO - 2015-11-18 11:48:28,468 DEBUG : BROWSER_OUTPUT: RSS: Main: 139870208 11:48:28 INFO - 2015-11-18 11:48:28,469 DEBUG : BROWSER_OUTPUT: 11:48:31 INFO - 2015-11-18 11:48:31,097 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42657/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42657/tests/kraken/driver.html?testName=audio-beat-detection) 11:48:31 INFO - 2015-11-18 11:48:31,698 DEBUG : BROWSER_OUTPUT: RSS: Main: 179142656 11:48:31 INFO - 2015-11-18 11:48:31,699 DEBUG : BROWSER_OUTPUT: 11:48:34 INFO - 2015-11-18 11:48:34,429 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42657/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42657/tests/kraken/driver.html?testName=audio-dft) 11:48:35 INFO - 2015-11-18 11:48:35,010 DEBUG : BROWSER_OUTPUT: RSS: Main: 168374272 11:48:35 INFO - 2015-11-18 11:48:35,010 DEBUG : BROWSER_OUTPUT: 11:48:38 INFO - 2015-11-18 11:48:38,042 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42657/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42657/tests/kraken/driver.html?testName=audio-fft) 11:48:38 INFO - 2015-11-18 11:48:38,609 DEBUG : BROWSER_OUTPUT: RSS: Main: 152293376 11:48:38 INFO - 2015-11-18 11:48:38,609 DEBUG : BROWSER_OUTPUT: 11:48:40 INFO - 2015-11-18 11:48:40,665 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42657/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42657/tests/kraken/driver.html?testName=audio-oscillator) 11:48:41 INFO - 2015-11-18 11:48:41,232 DEBUG : BROWSER_OUTPUT: RSS: Main: 154226688 11:48:41 INFO - 2015-11-18 11:48:41,232 DEBUG : BROWSER_OUTPUT: 11:48:43 INFO - 2015-11-18 11:48:43,447 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42657/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42657/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:48:44 INFO - 2015-11-18 11:48:44,008 DEBUG : BROWSER_OUTPUT: RSS: Main: 156536832 11:48:44 INFO - 2015-11-18 11:48:44,009 DEBUG : BROWSER_OUTPUT: 11:48:47 INFO - 2015-11-18 11:48:47,028 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42657/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42657/tests/kraken/driver.html?testName=imaging-darkroom) 11:48:47 INFO - 2015-11-18 11:48:47,601 DEBUG : BROWSER_OUTPUT: RSS: Main: 154595328 11:48:47 INFO - 2015-11-18 11:48:47,602 DEBUG : BROWSER_OUTPUT: 11:48:51 INFO - 2015-11-18 11:48:51,032 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42657/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42657/tests/kraken/driver.html?testName=imaging-desaturate) 11:48:51 INFO - 2015-11-18 11:48:51,613 DEBUG : BROWSER_OUTPUT: RSS: Main: 155508736 11:48:51 INFO - 2015-11-18 11:48:51,613 DEBUG : BROWSER_OUTPUT: 11:48:54 INFO - 2015-11-18 11:48:54,471 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42657/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42657/tests/kraken/driver.html?testName=json-parse-financial) 11:48:55 INFO - 2015-11-18 11:48:55,052 DEBUG : BROWSER_OUTPUT: RSS: Main: 155766784 11:48:55 INFO - 2015-11-18 11:48:55,052 DEBUG : BROWSER_OUTPUT: 11:48:56 INFO - 2015-11-18 11:48:56,842 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42657/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42657/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:48:57 INFO - 2015-11-18 11:48:57,407 DEBUG : BROWSER_OUTPUT: RSS: Main: 164896768 11:48:57 INFO - 2015-11-18 11:48:57,408 DEBUG : BROWSER_OUTPUT: 11:48:59 INFO - 2015-11-18 11:48:59,301 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42657/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42657/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:48:59 INFO - 2015-11-18 11:48:59,904 DEBUG : BROWSER_OUTPUT: RSS: Main: 166002688 11:48:59 INFO - 2015-11-18 11:48:59,904 DEBUG : BROWSER_OUTPUT: 11:49:02 INFO - 2015-11-18 11:49:02,056 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42657/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42657/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:49:02 INFO - 2015-11-18 11:49:02,639 DEBUG : BROWSER_OUTPUT: RSS: Main: 173199360 11:49:02 INFO - 2015-11-18 11:49:02,639 DEBUG : BROWSER_OUTPUT: 11:49:05 INFO - 2015-11-18 11:49:05,174 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42657/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42657/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:49:05 INFO - 2015-11-18 11:49:05,754 DEBUG : BROWSER_OUTPUT: RSS: Main: 181698560 11:49:05 INFO - 2015-11-18 11:49:05,755 DEBUG : BROWSER_OUTPUT: 11:49:08 INFO - 2015-11-18 11:49:08,476 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42657/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42657/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:49:09 INFO - 2015-11-18 11:49:09,061 DEBUG : BROWSER_OUTPUT: RSS: Main: 178630656 11:49:09 INFO - 2015-11-18 11:49:09,062 DEBUG : BROWSER_OUTPUT: 11:49:10 INFO - 2015-11-18 11:49:10,842 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42657/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42657/tests/kraken/driver.html?testName=ai-astar) 11:49:11 INFO - 2015-11-18 11:49:11,100 DEBUG : BROWSER_OUTPUT: RSS: Main: 237764608 11:49:11 INFO - 2015-11-18 11:49:11,100 DEBUG : BROWSER_OUTPUT: 11:49:11 INFO - 2015-11-18 11:49:11,100 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:49:11 INFO - 2015-11-18 11:49:11,100 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:49:11 INFO - 2015-11-18 11:49:11,101 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:49:11 INFO - 2015-11-18 11:49:11,101 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:49:11 INFO - 2015-11-18 11:49:11,101 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;108;113;114;115;122;112;112;111;112 11:49:11 INFO - 2015-11-18 11:49:11,101 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;156;137;159;167;131;156;151;133;175;143 11:49:11 INFO - 2015-11-18 11:49:11,101 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;162;160;161;161;161;162;162;161;161 11:49:11 INFO - 2015-11-18 11:49:11,101 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;72;81;96;73;74;73;119;88;73 11:49:11 INFO - 2015-11-18 11:49:11,101 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;92;127;91;92;91;140;93;93;129 11:49:11 INFO - 2015-11-18 11:49:11,101 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;110;110;110;110;111;110;110;110 11:49:11 INFO - 2015-11-18 11:49:11,101 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;150;149;148;149;148;148;148;147;147;148 11:49:11 INFO - 2015-11-18 11:49:11,101 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;97;95;97;95;95;95;95;95;96;95 11:49:11 INFO - 2015-11-18 11:49:11,101 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;74;73;72;71;72;72;72;79;70;70 11:49:11 INFO - 2015-11-18 11:49:11,102 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;70;70;69;69;70;70;69;70;70 11:49:11 INFO - 2015-11-18 11:49:11,102 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;84;83;82;83;83;92;86;86;85 11:49:11 INFO - 2015-11-18 11:49:11,102 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;127;122;128;122;128;127;128;124;123;123 11:49:11 INFO - 2015-11-18 11:49:11,102 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;155;149;153;158;154;144;158;168;157;153 11:49:11 INFO - 2015-11-18 11:49:11,102 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;70;72;71;69;69;72;71;68;69 11:49:11 INFO - 2015-11-18 11:49:11,102 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:49:11 INFO - 2015-11-18 11:49:11,102 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:49:11 INFO - 2015-11-18 11:49:11,102 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,996 11:49:11 INFO - 2015-11-18 11:49:11,102 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:49:11 INFO - 2015-11-18 11:49:11,102 DEBUG : BROWSER_OUTPUT: __startTimestamp1447876151095__endTimestamp 11:49:11 INFO - 2015-11-18 11:49:11,102 DEBUG : BROWSER_OUTPUT: 11:49:11 INFO - 2015-11-18 11:49:11,103 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:49:11 INFO - 2015-11-18 11:49:11,103 DEBUG : BROWSER_OUTPUT: Number of tests: 14 11:49:11 INFO - 2015-11-18 11:49:11,104 DEBUG : BROWSER_OUTPUT: 11:49:11 INFO - 2015-11-18 11:49:11,104 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:113.10 Median:112.50 stddev:3.63 (3.2%) stddev-sans-first:3.83 11:49:11 INFO - 2015-11-18 11:49:11,104 DEBUG : BROWSER_OUTPUT: Values: 112.0 108.0 113.0 114.0 115.0 122.0 112.0 112.0 111.0 112.0 11:49:11 INFO - 2015-11-18 11:49:11,104 DEBUG : BROWSER_OUTPUT: 11:49:11 INFO - 2015-11-18 11:49:11,104 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.80 Median:156.00 stddev:14.64 (9.4%) stddev-sans-first:15.41 11:49:11 INFO - 2015-11-18 11:49:11,104 DEBUG : BROWSER_OUTPUT: Values: 156.0 137.0 159.0 167.0 131.0 156.0 151.0 133.0 175.0 143.0 11:49:11 INFO - 2015-11-18 11:49:11,104 DEBUG : BROWSER_OUTPUT: 11:49:11 INFO - 2015-11-18 11:49:11,104 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:0.67 (0.4%) stddev-sans-first:0.67 11:49:11 INFO - 2015-11-18 11:49:11,104 DEBUG : BROWSER_OUTPUT: Values: 162.0 162.0 160.0 161.0 161.0 161.0 162.0 162.0 161.0 161.0 11:49:11 INFO - 2015-11-18 11:49:11,104 DEBUG : BROWSER_OUTPUT: 11:49:11 INFO - 2015-11-18 11:49:11,104 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:82.20 Median:73.50 stddev:15.24 (20.7%) stddev-sans-first:15.79 11:49:11 INFO - 2015-11-18 11:49:11,104 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 81.0 96.0 73.0 74.0 73.0 119.0 88.0 73.0 11:49:11 INFO - 2015-11-18 11:49:11,104 DEBUG : BROWSER_OUTPUT: 11:49:11 INFO - 2015-11-18 11:49:11,105 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.90 Median:91.50 stddev:19.68 (21.5%) stddev-sans-first:20.32 11:49:11 INFO - 2015-11-18 11:49:11,105 DEBUG : BROWSER_OUTPUT: Values: 91.0 92.0 127.0 91.0 92.0 91.0 140.0 93.0 93.0 129.0 11:49:11 INFO - 2015-11-18 11:49:11,105 DEBUG : BROWSER_OUTPUT: 11:49:11 INFO - 2015-11-18 11:49:11,105 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.47 (0.4%) stddev-sans-first:0.33 11:49:11 INFO - 2015-11-18 11:49:11,105 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 110.0 110.0 110.0 110.0 111.0 110.0 110.0 110.0 11:49:11 INFO - 2015-11-18 11:49:11,105 DEBUG : BROWSER_OUTPUT: 11:49:11 INFO - 2015-11-18 11:49:11,105 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:0.92 (0.6%) stddev-sans-first:0.71 11:49:11 INFO - 2015-11-18 11:49:11,105 DEBUG : BROWSER_OUTPUT: Values: 150.0 149.0 148.0 149.0 148.0 148.0 148.0 147.0 147.0 148.0 11:49:11 INFO - 2015-11-18 11:49:11,105 DEBUG : BROWSER_OUTPUT: 11:49:11 INFO - 2015-11-18 11:49:11,105 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.00 stddev:0.85 (0.9%) stddev-sans-first:0.71 11:49:11 INFO - 2015-11-18 11:49:11,105 DEBUG : BROWSER_OUTPUT: Values: 97.0 95.0 97.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 11:49:11 INFO - 2015-11-18 11:49:11,105 DEBUG : BROWSER_OUTPUT: 11:49:11 INFO - 2015-11-18 11:49:11,105 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.50 Median:72.00 stddev:2.59 (3.6%) stddev-sans-first:2.69 11:49:11 INFO - 2015-11-18 11:49:11,106 DEBUG : BROWSER_OUTPUT: Values: 74.0 73.0 72.0 71.0 72.0 72.0 72.0 79.0 70.0 70.0 11:49:11 INFO - 2015-11-18 11:49:11,106 DEBUG : BROWSER_OUTPUT: 11:49:11 INFO - 2015-11-18 11:49:11,106 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.60 Median:70.00 stddev:0.52 (0.7%) stddev-sans-first:0.50 11:49:11 INFO - 2015-11-18 11:49:11,106 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 70.0 69.0 69.0 70.0 70.0 69.0 70.0 70.0 11:49:11 INFO - 2015-11-18 11:49:11,106 DEBUG : BROWSER_OUTPUT: 11:49:11 INFO - 2015-11-18 11:49:11,106 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:84.50 stddev:2.91 (3.4%) stddev-sans-first:3.02 11:49:11 INFO - 2015-11-18 11:49:11,106 DEBUG : BROWSER_OUTPUT: Values: 83.0 84.0 83.0 82.0 83.0 83.0 92.0 86.0 86.0 85.0 11:49:11 INFO - 2015-11-18 11:49:11,106 DEBUG : BROWSER_OUTPUT: 11:49:11 INFO - 2015-11-18 11:49:11,106 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.20 Median:127.00 stddev:2.62 (2.1%) stddev-sans-first:2.69 11:49:11 INFO - 2015-11-18 11:49:11,106 DEBUG : BROWSER_OUTPUT: Values: 127.0 122.0 128.0 122.0 128.0 127.0 128.0 124.0 123.0 123.0 11:49:11 INFO - 2015-11-18 11:49:11,106 DEBUG : BROWSER_OUTPUT: 11:49:11 INFO - 2015-11-18 11:49:11,106 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.90 Median:156.00 stddev:6.30 (4.0%) stddev-sans-first:6.68 11:49:11 INFO - 2015-11-18 11:49:11,106 DEBUG : BROWSER_OUTPUT: Values: 155.0 149.0 153.0 158.0 154.0 144.0 158.0 168.0 157.0 153.0 11:49:11 INFO - 2015-11-18 11:49:11,106 DEBUG : BROWSER_OUTPUT: 11:49:11 INFO - 2015-11-18 11:49:11,107 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.20 Median:71.00 stddev:1.40 (2.0%) stddev-sans-first:1.45 11:49:11 INFO - 2015-11-18 11:49:11,107 DEBUG : BROWSER_OUTPUT: Values: 71.0 70.0 72.0 71.0 69.0 69.0 72.0 71.0 68.0 69.0 11:49:11 INFO - 2015-11-18 11:49:11,107 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:49:11 INFO - 2015-11-18 11:49:11,107 DEBUG : BROWSER_OUTPUT: 11:49:12 INFO - 2015-11-18 11:49:12,053 INFO : Browser exited with error code: 0 11:49:12 INFO - 2015-11-18 11:49:12,103 INFO : Completed test kraken (00:01:01) 11:49:12 INFO - 2015-11-18 11:49:12,103 INFO : Starting test v8_7 11:49:12 INFO - 2015-11-18 11:49:12,103 DEBUG : operating with platform_type : linux_ 11:49:12 INFO - 2015-11-18 11:49:12,103 INFO : Initialising browser for v8_7 test... 11:49:12 INFO - 2015-11-18 11:49:12,109 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_FBjlG/profile http://localhost:42657/getInfo.html 11:49:16 INFO - 2015-11-18 11:49:16,636 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:49:16 INFO - 2015-11-18 11:49:16,636 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:49:16 INFO - 2015-11-18 11:49:16,636 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:49:16 INFO - 2015-11-18 11:49:16,636 DEBUG : BROWSER_OUTPUT: __metrics 11:49:16 INFO - 2015-11-18 11:49:16,732 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:49:18 INFO - 2015-11-18 11:49:18,130 INFO : Browser initialized. 11:49:18 INFO - 2015-11-18 11:49:18,130 INFO : Running cycle 1/1 for v8_7 test... 11:49:18 INFO - 2015-11-18 11:49:18,131 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_FBjlG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:49:30 INFO - 2015-11-18 11:49:30,111 DEBUG : BROWSER_OUTPUT: RSS: Main: 139796480 11:49:30 INFO - 2015-11-18 11:49:30,112 DEBUG : BROWSER_OUTPUT: 11:49:51 INFO - 2015-11-18 11:49:51,519 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42657/tests/v8_7/run.html (next: http://localhost:42657/tests/v8_7/run.html) 11:49:51 INFO - 2015-11-18 11:49:51,769 DEBUG : BROWSER_OUTPUT: RSS: Main: 436039680 11:49:51 INFO - 2015-11-18 11:49:51,769 DEBUG : BROWSER_OUTPUT: 11:49:51 INFO - 2015-11-18 11:49:51,771 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:49:51 INFO - 2015-11-18 11:49:51,771 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:49:51 INFO - 2015-11-18 11:49:51,771 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:49:51 INFO - 2015-11-18 11:49:51,771 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:49:51 INFO - 2015-11-18 11:49:51,771 DEBUG : BROWSER_OUTPUT: |0;Richards;163.15875346712352 11:49:51 INFO - 2015-11-18 11:49:51,771 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;187.72292096865027 11:49:51 INFO - 2015-11-18 11:49:51,771 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.2516056967328 11:49:51 INFO - 2015-11-18 11:49:51,772 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5035.175879396985 11:49:51 INFO - 2015-11-18 11:49:51,772 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2002 11:49:51 INFO - 2015-11-18 11:49:51,772 DEBUG : BROWSER_OUTPUT: |5;Earley;793.6507936507936 11:49:51 INFO - 2015-11-18 11:49:51,772 DEBUG : BROWSER_OUTPUT: |6;Boyer;12256.09756097561 11:49:51 INFO - 2015-11-18 11:49:51,772 DEBUG : BROWSER_OUTPUT: |7;RegExp;26394.736842105263 11:49:51 INFO - 2015-11-18 11:49:51,772 DEBUG : BROWSER_OUTPUT: |8;Splay;608.853850818678 11:49:51 INFO - 2015-11-18 11:49:51,772 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4859.223300970873 11:49:51 INFO - 2015-11-18 11:49:51,773 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:49:51 INFO - 2015-11-18 11:49:51,773 DEBUG : BROWSER_OUTPUT: __startTimestamp1447876191770__endTimestamp 11:49:51 INFO - 2015-11-18 11:49:51,773 DEBUG : BROWSER_OUTPUT: 11:49:51 INFO - 2015-11-18 11:49:51,774 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:49:51 INFO - 2015-11-18 11:49:51,774 DEBUG : BROWSER_OUTPUT: Number of tests: 10 11:49:51 INFO - 2015-11-18 11:49:51,774 DEBUG : BROWSER_OUTPUT: 11:49:51 INFO - 2015-11-18 11:49:51,774 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.16 Median:163.16 stddev:0.00 (0.0%) 11:49:51 INFO - 2015-11-18 11:49:51,774 DEBUG : BROWSER_OUTPUT: Values: 163.2 11:49:51 INFO - 2015-11-18 11:49:51,775 DEBUG : BROWSER_OUTPUT: 11:49:51 INFO - 2015-11-18 11:49:51,775 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:187.72 Median:187.72 stddev:0.00 (0.0%) 11:49:51 INFO - 2015-11-18 11:49:51,775 DEBUG : BROWSER_OUTPUT: Values: 187.7 11:49:51 INFO - 2015-11-18 11:49:51,775 DEBUG : BROWSER_OUTPUT: 11:49:51 INFO - 2015-11-18 11:49:51,775 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.25 Median:279.25 stddev:0.00 (0.0%) 11:49:51 INFO - 2015-11-18 11:49:51,776 DEBUG : BROWSER_OUTPUT: Values: 279.3 11:49:51 INFO - 2015-11-18 11:49:51,776 DEBUG : BROWSER_OUTPUT: 11:49:51 INFO - 2015-11-18 11:49:51,776 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5035.18 Median:5035.18 stddev:0.00 (0.0%) 11:49:51 INFO - 2015-11-18 11:49:51,777 DEBUG : BROWSER_OUTPUT: Values: 5035.2 11:49:51 INFO - 2015-11-18 11:49:51,778 DEBUG : BROWSER_OUTPUT: 11:49:51 INFO - 2015-11-18 11:49:51,778 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2002.00 Median:2002.00 stddev:0.00 (0.0%) 11:49:51 INFO - 2015-11-18 11:49:51,778 DEBUG : BROWSER_OUTPUT: Values: 2002.0 11:49:51 INFO - 2015-11-18 11:49:51,778 DEBUG : BROWSER_OUTPUT: 11:49:51 INFO - 2015-11-18 11:49:51,778 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:793.65 Median:793.65 stddev:0.00 (0.0%) 11:49:51 INFO - 2015-11-18 11:49:51,778 DEBUG : BROWSER_OUTPUT: Values: 793.7 11:49:51 INFO - 2015-11-18 11:49:51,778 DEBUG : BROWSER_OUTPUT: 11:49:51 INFO - 2015-11-18 11:49:51,779 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12256.10 Median:12256.10 stddev:0.00 (0.0%) 11:49:51 INFO - 2015-11-18 11:49:51,779 DEBUG : BROWSER_OUTPUT: Values: 12256.1 11:49:51 INFO - 2015-11-18 11:49:51,779 DEBUG : BROWSER_OUTPUT: 11:49:51 INFO - 2015-11-18 11:49:51,779 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26394.74 Median:26394.74 stddev:0.00 (0.0%) 11:49:51 INFO - 2015-11-18 11:49:51,779 DEBUG : BROWSER_OUTPUT: Values: 26394.7 11:49:51 INFO - 2015-11-18 11:49:51,779 DEBUG : BROWSER_OUTPUT: 11:49:51 INFO - 2015-11-18 11:49:51,779 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:608.85 Median:608.85 stddev:0.00 (0.0%) 11:49:51 INFO - 2015-11-18 11:49:51,779 DEBUG : BROWSER_OUTPUT: Values: 608.9 11:49:51 INFO - 2015-11-18 11:49:51,780 DEBUG : BROWSER_OUTPUT: 11:49:51 INFO - 2015-11-18 11:49:51,780 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4859.22 Median:4859.22 stddev:0.00 (0.0%) 11:49:51 INFO - 2015-11-18 11:49:51,780 DEBUG : BROWSER_OUTPUT: Values: 4859.2 11:49:51 INFO - 2015-11-18 11:49:51,780 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:49:51 INFO - 2015-11-18 11:49:51,780 DEBUG : BROWSER_OUTPUT: 11:49:52 INFO - 2015-11-18 11:49:52,697 INFO : Browser exited with error code: 0 11:49:52 INFO - 2015-11-18 11:49:52,709 INFO : Completed test v8_7 (00:00:40) 11:49:52 INFO - 2015-11-18 11:49:52,793 INFO : Completed test suite (00:20:21) 11:49:52 INFO - 2015-11-18 11:49:52,793 DEBUG : Working with test: dromaeo_css 11:49:52 INFO - 2015-11-18 11:49:52,793 DEBUG : Generating results file: dromaeo_css 11:49:52 INFO - 2015-11-18 11:49:52,795 DEBUG : Working with test: kraken 11:49:52 INFO - 2015-11-18 11:49:52,795 DEBUG : Generating results file: kraken 11:49:52 INFO - 2015-11-18 11:49:52,795 INFO : javascript benchmark 11:49:52 INFO - 2015-11-18 11:49:52,795 DEBUG : Working with test: v8_7 11:49:52 INFO - 2015-11-18 11:49:52,795 DEBUG : Generating results file: v8_7 11:49:52 INFO - 2015-11-18 11:49:52,796 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:49:52 INFO - 2015-11-18 11:49:52,841 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 11:49:52 INFO - 2015-11-18 11:49:52,841 DEBUG : process_Request line: dromaeo_css 6098.46 graph.html#tests=[[72,132,35]] 11:49:52 INFO - 2015-11-18 11:49:52,841 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:49:52 INFO - 2015-11-18 11:49:52,868 DEBUG : process_Request line: kraken 1542.10 graph.html#tests=[[232,132,35]] 11:49:52 INFO - 2015-11-18 11:49:52,868 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:49:52 INFO - 2015-11-18 11:49:52,892 DEBUG : process_Request line: v8_7 19850.85 graph.html#tests=[[230,132,35]] 11:49:52 INFO - 2015-11-18 11:49:52,894 INFO : javascript benchmark 11:49:52 INFO - 2015-11-18 11:49:52,897 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2655.907043253486, 2737.8083534152615, 2777.139086883065, 2782.0541016054535, 2793.441311737653, 4518.2093133701555, 4649.69776964497, 4676.7427791471455, 4741.976290118545, 4773.832915847942, 4604.76976151192, 4669.836555720551, 4682.41469816273, 4682.484926658065, 4694.882627934303, 4321.243782338094, 4331.675124365685, 4404.735715857051, 4467.10657868426, 4477.6417886569, 4176.477940257468, 4418.977905110486, 4436.64506839452, 4484.66365022623, 4522.050369422425, 4272.380504826814, 4290.42079319291, 4366.628836548897, 4382.0, 4411.360352748866, 4361.738295702268, 4392.187445322594, 4413.227685155085, 4416.514183439819, 4421.491528474235, 4086.284900142493, 4349.69552131351, 4375.496817865923, 4378.430803995492, 4418.646508279362, 4563.247064234397, 4640.0, 4754.429468463806, 4762.285657151455, 4781.474037855833, 5139.203423469368, 5143.3313669223135, 5143.588512918957, 5143.871403214912, 5187.896242075138, 4827.927581086286, 4946.010797840447, 5159.58723302135, 5171.922421163648, 5174.275601415805, 4571.200039993021, 4599.793009314555, 4676.929846052312, 4709.7174169549935, 4762.499937506512, 5114.130597798383, 5118.360204974379, 5121.487851214849, 5148.304978827885, 5157.9684063187515, 4756.21522448799, 4870.342503762017, 4921.87695307613, 4927.334809800631, 4950.6782059166035, 4938.481459446706, 5072.467390923974, 5204.687718736888, 5217.2434996925995, 5245.790168393221, 5147.536721694991, 5150.510701483353, 5154.0, 5158.871028224249, 5205.505476979681, 4749.905001899942, 5144.6913185209005, 5145.794168233228, 5147.845564633067, 5149.150390185578, 4187.685923555746, 4201.621854033152, 4269.423627810268, 4271.1671224111, 4303.268444364466, 3696.639872185342, 3751.6060813614176, 3772.1512659651357, 3790.3556395412847, 3804.4673745675627, 4160.417541544186, 4389.297712366006, 4401.097774956126, 4413.889652758707, 4448.088141930896, 4918.803247870117, 4937.333459982929, 5070.797168113234, 5208.348956380452, 5241.790328386822, 4402.3396490526675, 4403.581659742319, 4410.404595379647, 4414.668899832525, 4457.2645513489915, 4559.065391594715, 4566.4063671723125, 4580.885477863014, 4586.243269860435, 4617.215073437524, 4608.723476591415, 4707.693999889996, 4714.151452738472, 4725.692829966041, 4869.147899117711, 5115.0, 5148.279240906201, 5159.164659274028, 5167.767450464663, 5173.948260517497, 4898.92651610219, 4899.6570240084275, 4899.877503062452, 4903.705777653352, 4910.091633047898, 4798.4001999750035, 4930.309756634002, 4934.111859865258, 4947.381577302837, 5047.798088076436, 5137.614678899023, 5158.123119069692, 5171.069207542528, 5171.069207542679, 5185.0, 4997.3253610762085, 5000.324956130876, 5004.824831130893, 5008.398992120969, 5019.598432125495, 4585.266357382803, 4723.834665786681, 4724.692894961954, 4876.049170411736, 5008.824691135938, 4824.500069920224, 4838.225883858566, 4848.224284114524, 4852.636052296021, 4880.682755620874, 4986.227134794112, 4986.8753281168265, 4987.650864439454, 4988.925166122439, 5025.698458092526, 4481.843135490372, 4600.470945841271, 4609.124266389375, 4684.6486513510945, 4833.250846118857], "unit": "ms", "name": "dojo.html", "value": 4652.8907738017415}, {"lowerIsBetter": false, "replicates": [556.7049463784193, 565.2933832709114, 573.5640912906191, 582.935877053524, 584.9005669036266, 27455.313617159554, 27860.58209126862, 27996.020139295128, 28006.019789307404, 35889.641103588954, 39859.20281594367, 40410.19179616406, 40436.79781601095, 40468.19063618733, 40533.391999119965, 8025.277725004763, 8199.098099209083, 8199.549024803633, 8201.22088401601, 8205.0, 7297.927020729804, 7461.888071678929, 7940.2853743163105, 10186.236032297571, 10418.322809017389, 9940.6520771773, 10016.649417270397, 10019.499025048755, 10023.198144148488, 10027.298089133763, 7304.196538380774, 10105.343152695088, 10231.641892533726, 10242.846357304683, 10247.333923294962, 7099.467539934474, 10295.845562316572, 10506.054455099078, 10592.947035264775, 10599.470026498644, 37050.814745926094, 37555.81222093899, 37584.0, 37597.43603845945, 37598.43602345967, 2803.5841899840652, 2873.066253467631, 2898.0146750104855, 3070.723634872872, 3387.779794313362, 28600.998965036124, 28754.568681469795, 28923.71076289231, 28931.710682893114, 29357.0, 3069.9539506907413, 3135.18485193849, 3165.0663054399006, 3167.160702413862, 3173.8571764270664, 214123.0, 214163.0, 214526.0, 215236.92381538148, 215805.99999999843, 44687.77656111699, 46414.0, 46583.30125048127, 54752.45247547473, 55319.72340138354, 64815.0, 66317.33682663208, 66439.0, 66480.33519664838, 66496.33503664998, 12823.679408014874, 12940.547080852126, 12956.157849739737, 13040.54358097462, 13041.347932603332, 9306.90693093074, 9320.161185493202, 9321.906780932104, 9324.067593240758, 9565.713028609152, 18735.531611709543, 19014.0, 19015.04924753757, 19018.52453688669, 19062.2375104997, 7419.85160296791, 7617.27635874591, 7727.072751269883, 7803.609819509002, 7885.1326354101, 784.2862994674819, 800.6197056398164, 838.6896848166217, 848.6817443458702, 973.1047436358567, 26391.20826375212, 26514.072007479645, 26525.86737066302, 26677.599836002475, 26693.19920402391, 851.9776268477851, 917.7109210598641, 921.2261700171754, 1024.293237666008, 1044.6291566493785, 13904.443822246996, 13919.582412527641, 14013.5095271665, 14079.366428510742, 14121.223332716594, 249718.0, 253298.0, 254938.0, 255333.0, 255942.0, 45381.00808911017, 45723.08553828905, 45723.771381142884, 45768.77115614467, 45825.0, 1128.7065363005677, 1137.0846468592863, 1142.5658249864998, 1143.4740019591081, 1162.3490845126755, 25188.622170667088, 25595.616065758655, 26003.609945851207, 26430.07494737675, 26430.603540946515, 35934.8203258982, 36769.89690309295, 40489.0, 41581.0, 42730.57269427266, 203870.0, 204852.0, 205905.0, 206028.0, 206532.0, 23969.0, 27317.590236146076, 27540.173794786187, 27554.0, 27563.862180688968, 27739.167824964476, 37962.810185948896, 38530.61469385382, 38531.2293754129, 39250.214995700495, 31963.520547192275, 32214.35571288608, 33283.50074748929, 33590.83204583961, 33618.32763344768, 31413.685863141076, 32752.34495310128, 32918.0, 33094.0, 33121.171970700925, 30712.539311910787, 30811.075667730005, 31102.0, 33813.66186338203, 34398.0, 27128.593071104344, 30063.549046764754, 31897.39035864499, 32556.674433255364, 32899.177520562174, 23086.191983280503, 23230.419239519146, 23473.53052938966, 23554.528909421373, 23559.293221203392], "unit": "ms", "name": "ext.html", "value": 16762.821130714532}, {"lowerIsBetter": false, "replicates": [311.5778120646525, 314.1048013162487, 314.40734216002835, 318.2965645922512, 318.7577441144729, 12499.812502812465, 12910.806337904938, 15433.382664693412, 15544.689106217884, 15886.523404297875, 14810.777838332433, 15287.963332004778, 16274.83725162748, 16503.0, 16520.58698532537, 4410.911781764363, 4516.0967806438675, 4520.909581808378, 4521.389612402317, 4858.344123543312, 3092.087834088949, 3161.9051428457183, 4524.864254072367, 6476.125723027378, 6653.2681405045405, 6143.8771224575485, 6609.801705948805, 6613.107230523866, 6663.30035346289, 6668.466522678174, 6216.844578885519, 6236.656983865885, 6237.09562113491, 6249.437550620421, 6265.592736472115, 6138.14066030756, 6369.585976911532, 6374.936250637481, 6377.17096777416, 6379.330170332095, 20342.593148136955, 21001.369958901105, 21349.359519214293, 21629.0, 22329.441763955867, 1976.160131943918, 1977.2486455146952, 1978.5350442645968, 2006.8193862552293, 2120.8833514156713, 13542.119762215523, 13637.181769093788, 13765.449382024706, 13957.860421395859, 14062.367193476319, 1868.0566314011473, 1868.1780016792704, 1889.9811001889943, 1925.8459323254106, 1927.5181204698824, 57599.712001440144, 57791.0, 57828.42171578272, 58076.41923580752, 58873.705631471996, 14619.415223391157, 15284.541463756104, 15305.234738263265, 15375.692486150438, 15387.769183462256, 22242.0, 22261.66607500889, 22623.20818771335, 22657.773422265895, 22678.659820102712, 7689.19263477338, 7751.806204844924, 7764.728234511765, 7787.10448298453, 7849.607519623996, 6349.0476428536085, 6355.142055822497, 6389.137466442064, 6390.8721825563225, 6404.391582799627, 5769.221155144086, 7347.093353531533, 7391.85216295671, 7423.777286681408, 7450.5529668219, 999.8350272205005, 1003.1272792670424, 1008.8284991551454, 1021.0351218098825, 2053.2813515269536, 384.51167017887127, 396.6450027225617, 398.06653397782156, 399.21354930786305, 408.9672826173899, 8982.657638637094, 9445.19715824149, 9705.272104592184, 10027.448490332956, 10047.648332308334, 409.63747083831026, 410.9424680544726, 417.38167180151527, 430.4834198961259, 434.12090516703927, 5626.634268772516, 5732.312122545238, 5737.110747834093, 5846.210761547221, 5847.6783776891825, 310840.0, 316109.0, 318728.0, 439424.0, 447089.0, 61594.38405615976, 62926.68536657288, 63608.363916361166, 63728.36271637317, 65016.34983650198, 459.2009902769224, 473.3822361817861, 473.6873663382151, 475.707439924444, 476.96422768291825, 9643.710688679352, 9666.95166524163, 9719.562619682272, 9812.803743924938, 9876.654317098866, 30393.544096838123, 30770.911221333707, 30975.0, 32033.67966320307, 32047.679523204468, 39604.0, 41240.38139427971, 41276.793616031726, 41422.0, 41515.0, 5715.771369145354, 5773.624714393551, 5847.473727364558, 5848.327442344185, 5861.677607731615, 10595.15238780911, 10604.946975265075, 10658.307210031324, 10762.46187690628, 10791.514381852992, 9019.458832470073, 9115.453072815651, 9339.719808405758, 9369.484678342484, 9381.812363752822, 9085.2731781456, 9202.723918282461, 9275.907240927505, 9373.718788436357, 9412.95293523528, 7962.163972783006, 8909.331800115147, 9259.72220833376, 9351.438913665203, 9828.459434731158, 5788.131780232999, 5846.824595262149, 5851.678157701367, 5896.380880007709, 5922.763089476372, 9061.77345566366, 9153.359264851662, 9393.812123757623, 9424.952875235855, 9468.431894086378], "unit": "ms", "name": "jquery.html", "value": 7317.053666474597}, {"lowerIsBetter": false, "replicates": [1369.869862363075, 1588.4202266172847, 1642.3512712478564, 1663.8668906487483, 1667.7081510735618, 5578.804741834037, 6174.722137503812, 6522.543421960465, 6537.64042977636, 6547.247066587344, 6292.0, 6406.071119687655, 6409.839754006152, 6412.679366031692, 6414.71133798979, 1644.9177541122956, 1684.0400971446281, 1932.3043704266454, 1952.8047195280428, 1979.9604007919834, 1970.9310174143907, 1974.042589344167, 1976.1008741022872, 1982.7620685517759, 1984.3253293880077, 1906.2470324221924, 1931.5364312565023, 1945.5233467800408, 1948.5420926082359, 1949.8342640875471, 1972.339266345776, 1983.97024044638, 1990.3829812757947, 1999.4401567561033, 2015.2241387065937, 1973.990130049355, 1983.9008049597462, 1992.6911328744068, 1996.46095554201, 2001.7297664815355, 6635.369639884251, 6708.12794336738, 6728.192616885956, 6729.125213722234, 6729.6971636276485, 3942.546607140187, 3999.3800960851113, 4021.8190181441905, 4024.315866302706, 4026.1545075534173, 2283.0981762204, 2647.1396796041363, 2748.477789220042, 2762.9723702762917, 2766.5711814668557, 772.8763397856316, 844.6452489954172, 860.1785295043219, 868.5657171414293, 902.6254104546671, 8880.111988801133, 9008.549572521348, 9010.189082982562, 9011.504367259799, 9017.098290171061, 3667.6332366763645, 3667.9633203668154, 3726.2361215950664, 3733.962660373416, 3744.0, 7778.961105194438, 7788.922110778933, 7797.844043119106, 7808.297253247235, 7810.6875724971505, 4106.466159399319, 4111.075008123148, 4120.546739858613, 4127.628513433805, 4132.979335103305, 3784.810759462016, 3785.6971442284553, 3787.905302367408, 3788.507494025759, 3790.0903783092413, 3275.1484614000055, 3280.6227283862186, 3286.3098749262444, 3306.553615261957, 3306.8181250031, 1012.1093437774858, 1012.6253286284121, 1024.5031159887449, 1033.2199189611795, 1050.8476270940823, 860.3461369359331, 865.4115201662804, 874.8512752832033, 875.0112373018449, 932.9737288982066, 6542.411182993554, 6576.5067619928695, 6584.5061620378665, 6585.835354116185, 6587.242467116247, 1004.8141093897652, 1008.9243306752023, 1029.8300780371305, 1044.1594516414207, 1063.5798859450474, 5156.561692256125, 5214.634975551675, 5217.165253559412, 5219.086659834514, 5219.112750832368, 6732.091167692397, 7592.240775922474, 7923.445358824943, 7997.360211183091, 8118.634661440249, 7748.4188685848785, 7808.258215469635, 7825.217478252243, 7913.920860791319, 7930.246626570467, 6215.471684906834, 6303.180586523723, 6331.9366806331345, 6336.303006669263, 6348.714307856158, 6225.937740622536, 6420.165378500765, 6434.517411194272, 6435.163428754232, 6437.0, 7086.078809754905, 7111.679974401268, 7273.98164257015, 7360.374368178551, 7390.113186417664, 7084.752033678797, 7338.046054012944, 7514.436417268617, 7526.0, 7535.58554279498, 6031.215941927521, 6096.116063170904, 6104.664243466652, 6106.786262480792, 6110.908336375047, 6491.902621460587, 6549.901751473827, 6552.541322107407, 6584.473242140713, 6586.835329116619, 5994.400559943971, 6015.2781666200335, 6069.787557435468, 6119.3268740437625, 6162.537809664203, 6003.369646187262, 6033.818985430444, 6055.545834062551, 6078.878422431439, 6271.404216599416, 6176.474999625082, 6212.099245609271, 6242.65665388408, 6245.0320200369015, 6264.4048815364295, 5512.972435137799, 5590.832275031756, 5642.097264437671, 5643.379228284967, 5647.971760141173, 5880.676562789087, 5903.026000709835, 5911.497522710618, 5912.674802885883, 5936.1095835625], "unit": "ms", "name": "mootools.html", "value": 3894.7299808493435}, {"lowerIsBetter": false, "replicates": [272.47956403269757, 276.2513588176043, 280.58753632160716, 281.0962754743499, 286.046036468378, 5189.065968125736, 5216.113260745673, 5323.281357016806, 5330.093884039713, 5330.973345133274, 5166.948330516694, 5318.787248510064, 5365.248865158881, 5367.0, 5369.060414427469, 4090.97954510227, 4098.73358231714, 4102.118044620406, 4102.671786257092, 4108.650764685005, 3898.200868821885, 3976.3439032559595, 4097.221527909703, 4103.158852435244, 4107.116969851481, 3960.069383694844, 4051.513818341803, 4072.1041370898356, 4073.307537718595, 4077.2864748669012, 4023.7988100595, 4068.613481719232, 4074.6740260779065, 4076.612721791425, 4076.9796151019054, 3546.556680414948, 3549.432090865475, 3550.6626870447267, 3550.7336949728874, 3553.502509648651, 5164.070467315882, 5178.430372659004, 5182.170852663556, 5182.32629758129, 5184.11869982104, 4586.770661466947, 4694.906101877978, 4706.599939005188, 4718.0, 4722.574968252874, 5594.9720251398885, 5601.327840659106, 5616.32604087508, 5616.971915140439, 5622.212890195376, 3619.8009109498967, 3731.1791405890663, 3867.9613203867884, 3868.1683438060672, 3871.7676939383446, 5716.0, 5893.0, 5917.053271476543, 5924.20023296858, 5925.940740592625, 3974.3243648579232, 3975.0, 3975.0658595230097, 3975.5626881043063, 3979.9602003980167, 4040.717149799486, 4043.251998380309, 4045.110075783323, 4045.8381664733083, 4047.534533528682, 4564.406627138451, 4662.230731929194, 4669.299605059268, 4681.29780532916, 4681.344611754357, 5622.85942851432, 5639.097744360883, 5639.802606908821, 5646.661200327993, 5647.407022262685, 1409.3235247081254, 1413.321605629283, 1416.4263473293333, 1417.0576566583106, 1417.0859795431888, 949.6248981652209, 955.2167222877313, 959.5346257065457, 975.7999610080059, 979.0698836105586, 4953.034158339161, 4957.355543779286, 4964.851054468371, 4966.726830024311, 4968.652194346433, 5824.621399609012, 5831.3877042910735, 5833.766649334064, 5837.153612726131, 5841.7371218295275, 4918.43438004634, 4947.48051454592, 4947.529984651453, 4963.950360496421, 4964.032013757354, 3058.4189004089153, 3115.5638210650527, 3143.4184675835045, 3149.779515433898, 3151.11768704763, 5536.086545719992, 5555.916661250085, 5557.749901254453, 5562.777488900399, 5563.638363506359, 5949.077892926603, 5990.520758339322, 5993.9700301498215, 6003.879922401527, 6005.099235114681, 5540.944590554042, 5551.139573366135, 5551.750171242304, 5552.944470555404, 5559.972200139055, 5722.2561067061015, 5897.5576831736935, 5897.882042359043, 5899.085641725539, 5909.054551271776, 5504.256925315031, 5776.393478684846, 5776.480116789509, 5781.739821707949, 5783.595148339576, 5444.8094316698725, 5504.779808807602, 5591.217229587943, 5592.804251851166, 5597.860053498695, 3802.372608519563, 3840.0, 3844.750091244172, 3847.557530883872, 3849.1147036182397, 5797.072468405035, 5853.502452291603, 5854.707264636836, 5855.414458554111, 5864.06175011996, 5424.376196737426, 5605.355384130877, 5607.327120745536, 5623.718814059363, 5625.915611265752, 5556.249906262603, 5557.749901254372, 5561.582881283839, 5564.0, 5573.303337082864, 5493.121100623881, 5496.5053145217125, 5496.945030549643, 5498.890022199614, 5516.862078447911, 5530.695811730394, 5662.178984047372, 5670.489655930986, 5682.886342273214, 5687.3459552152035, 5478.123500239943, 5487.6981766003255, 5493.983613031602, 5506.862328441821, 5511.0], "unit": "ms", "name": "prototype.html", "value": 4185.896125404516}, {"lowerIsBetter": false, "replicates": [767.0756738130553, 770.5415277909642, 784.5410434895585, 785.8428314337134, 787.7991112266371, 11763.882361176386, 12047.939760301208, 12058.155929084967, 12066.215695979756, 12071.155019148664, 12027.398630068505, 12090.758184836299, 12097.395130243496, 12112.0, 12157.756844863097, 608.1273372710153, 619.7087368936615, 778.1090651204396, 781.9218078192177, 795.2445177081767, 783.2598194705977, 784.6978913118462, 789.498668345599, 790.5888937752366, 790.8774140008308, 643.318082832197, 829.5271695133777, 834.9958250208771, 835.106436113359, 835.4235577451569, 644.4232411991266, 814.1939479914871, 829.6847198064758, 830.1325115254574, 831.3847752663046, 615.6244690738646, 615.8768246350703, 615.9014557670752, 616.5191150902303, 616.9660668663222, 11763.235389699643, 11945.04439644835, 11954.342511161884, 11968.34174120423, 11977.461014254379, 10951.45242737868, 11642.534298628045, 11689.76620467586, 11945.522179112912, 12117.151799374047, 9056.728298151065, 9084.454932703993, 9112.908870911273, 9146.2682985361, 9222.631094756201, 3239.0768630940306, 3270.117068391521, 3292.0946739646547, 3325.068980685412, 3345.5650765400587, 39209.21581568353, 39314.21371572553, 39459.210815783525, 39558.0, 39801.0, 7300.4159667226495, 9737.269704772028, 9744.171745401578, 9750.902490974999, 9797.608095676236, 10647.361158330525, 10721.088707459798, 10722.142228621691, 10760.461976901124, 10763.892361076289, 5621.494065534122, 5624.887502250014, 5628.690422026828, 5794.884102318014, 5885.205497257901, 3525.383057964897, 3538.6815186633326, 3599.1002249437643, 3621.5654121505063, 3671.5564184855407, 2484.5900426429434, 2503.561876671575, 2507.5611767940904, 2508.4481414088873, 2509.9749002510107, 390.45141576085643, 398.82053076115864, 398.9281929252704, 399.9660028897518, 463.367503357914, 526.5813678125899, 587.6562211106465, 590.1177739279805, 601.5488383712216, 605.6456972671036, 7736.690532378754, 7740.458167928191, 7779.416543759241, 7928.207179282141, 8006.1993800619475, 454.9112922979987, 458.9609883159969, 460.7903403951194, 501.9046381187563, 535.6325043308585, 3496.9125771855397, 3559.199180184438, 3737.439384092408, 3846.3076646203394, 3894.4937158169255, 45659.77170114128, 46583.0, 50238.24642630364, 50503.0, 50728.0, 44118.558814412085, 44670.0, 45193.87015324643, 45239.095218095455, 45376.3193552097, 41528.0, 41736.0, 41765.37351939723, 42576.361354579705, 43156.56843431589, 8059.153788852086, 8340.374471914509, 8673.262772664395, 8737.082606326498, 8772.824543509221, 32199.67800321967, 32453.0, 32866.0, 33143.50284745779, 33165.0, 37269.254614908095, 37322.813385932895, 38242.808785955895, 40830.38754418627, 41146.58853411428, 6912.205096413977, 6994.755183568551, 7206.783796486114, 7241.601711905896, 7595.392368610387, 10614.150867930393, 10843.186760993114, 11287.943560282147, 11518.308901465938, 11602.94198529002, 10272.486375681037, 10387.94806025965, 10465.47672616351, 10483.37099774016, 10641.414722190353, 10404.323718958243, 10758.300710453796, 11009.394483303175, 11076.280041797258, 11201.047910927336, 7605.505642133244, 9994.850077248702, 10328.0, 10439.217058720475, 10494.947525262325, 9021.503817290111, 9120.45277283365, 9155.633774649206, 9159.358844880795, 9389.718308450758, 9087.681931132378, 9290.210332121846, 9375.578098985425, 9430.622775089194, 9545.331826772059], "unit": "ms", "name": "yui.html", "value": 5528.454146609246}], "name": "dromaeo_css", "value": 6098.459447988882}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 108.0, 113.0, 114.0, 115.0, 122.0, 112.0, 112.0, 111.0, 112.0], "unit": "ms", "name": "ai-astar", "value": 113.1}, {"lowerIsBetter": true, "replicates": [156.0, 137.0, 159.0, 167.0, 131.0, 156.0, 151.0, 133.0, 175.0, 143.0], "unit": "ms", "name": "audio-beat-detection", "value": 150.8}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 160.0, 161.0, 161.0, 161.0, 162.0, 162.0, 161.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 161.3}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 81.0, 96.0, 73.0, 74.0, 73.0, 119.0, 88.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 82.2}, {"lowerIsBetter": true, "replicates": [91.0, 92.0, 127.0, 91.0, 92.0, 91.0, 140.0, 93.0, 93.0, 129.0], "unit": "ms", "name": "audio-oscillator", "value": 103.9}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 110.0, 110.0, 110.0, 111.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [150.0, 149.0, 148.0, 149.0, 148.0, 148.0, 148.0, 147.0, 147.0, 148.0], "unit": "ms", "name": "imaging-darkroom", "value": 148.2}, {"lowerIsBetter": true, "replicates": [97.0, 95.0, 97.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 72.0, 71.0, 72.0, 72.0, 72.0, 79.0, 70.0, 70.0], "unit": "ms", "name": "json-parse-financial", "value": 72.5}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 70.0, 69.0, 69.0, 70.0, 70.0, 69.0, 70.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.6}, {"lowerIsBetter": true, "replicates": [83.0, 84.0, 83.0, 82.0, 83.0, 83.0, 92.0, 86.0, 86.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.7}, {"lowerIsBetter": true, "replicates": [127.0, 122.0, 128.0, 122.0, 128.0, 127.0, 128.0, 124.0, 123.0, 123.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 125.2}, {"lowerIsBetter": true, "replicates": [155.0, 149.0, 153.0, 158.0, 154.0, 144.0, 158.0, 168.0, 157.0, 153.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 154.9}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 72.0, 71.0, 69.0, 69.0, 72.0, 71.0, 68.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 70.2}], "name": "kraken", "value": 1542.1000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [163.15875346712352], "unit": "score", "name": "Richards", "value": 216.36595800000006}, {"lowerIsBetter": false, "replicates": [187.72292096865027], "unit": "score", "name": "DeltaBlue", "value": 352.210586}, {"lowerIsBetter": false, "replicates": [279.2516056967328], "unit": "score", "name": "Encrypt", "value": 953.1941609999996}, {"lowerIsBetter": false, "replicates": [5035.175879396985], "unit": "score", "name": "Decrypt", "value": 52.864290419161705}, {"lowerIsBetter": false, "replicates": [2002.0], "unit": "score", "name": "RayTrace", "value": 369.62487512487513}, {"lowerIsBetter": false, "replicates": [793.6507936507936], "unit": "score", "name": "Earley", "value": 839.7433799999998}, {"lowerIsBetter": false, "replicates": [12256.09756097561], "unit": "score", "name": "Boyer", "value": 54.378075621890574}, {"lowerIsBetter": false, "replicates": [26394.736842105263], "unit": "score", "name": "RegExp", "value": 34.51388833499503}, {"lowerIsBetter": false, "replicates": [608.853850818678], "unit": "score", "name": "Splay", "value": 133.84328585657374}, {"lowerIsBetter": false, "replicates": [4859.223300970873], "unit": "score", "name": "NavierStokes", "value": 305.39860139860156}], "name": "v8_7", "value": 19850.845936742156}]} 11:49:52 INFO - RETURN: dromaeo_css: 6098.46 11:49:52 INFO - RETURN: kraken: 1542.10 11:49:52 INFO - RETURN: v8_7: 19850.85 11:49:52 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19850.85"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1542.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6098.46"}}} 11:49:52 INFO - Return code: 0 11:49:52 INFO - # TBPL SUCCESS # 11:49:53 INFO - Running post-action listener: _resource_record_post_action 11:49:53 INFO - Running post-run listener: _resource_record_post_run 11:49:54 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 4096; Write bytes: 493232128; Read time: 364; Write time: 536056 11:49:54 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 121544704; Read time: 0; Write time: 134188 11:49:54 INFO - run-tests - Wall time: 1222s; CPU: 13.0%; Read bytes: 4096; Write bytes: 320045056; Read time: 364; Write time: 360692 11:49:54 INFO - Running post-run listener: _upload_blobber_files 11:49:54 INFO - Blob upload gear active. 11:49:54 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 11:49:54 INFO - Copying logs to upload dir... 11:49:54 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1277.349658 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-11-18 11:49:54.048675) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-18 11:49:54.052660) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1447874161.778113-1850307875 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/fXTiJf9dSeSA50tLKrA_Ag/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010078 build_url: 'https://queue.taskcluster.net/v1/task/fXTiJf9dSeSA50tLKrA_Ag/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-18 11:49:54.105031) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 11:49:54.105536) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1447874161.778113-1850307875 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004527 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 11:49:54.156445) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 11:49:54.156833) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 11:49:54.157223) ========= ========= Total master_lag: 0.27 =========