builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-056 starttime: 1448327675.81 results: success (0) buildid: 20151123162931 builduid: 81a1f98460e14c89a33def60e16739b1 revision: 19d89caa664dd9309c796929225ee409df5d1ee4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 17:14:35.808755) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 17:14:35.809164) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 17:14:35.809453) ========= 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=0ae9de487587ba4b94dd3100000001b5-1448327602.553804-1950711028 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005337 basedir: '/builds/slave/test' ========= master_lag: 0.08 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 17:14:35.898247) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 17:14:35.898559) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 17:14:36.067163) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 17:14:36.067450) ========= 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=0ae9de487587ba4b94dd3100000001b5-1448327602.553804-1950711028 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004597 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 17:14:36.115420) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 17:14:36.115673) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 17:14:36.115987) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 17:14:36.116247) ========= 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=0ae9de487587ba4b94dd3100000001b5-1448327602.553804-1950711028 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-23 17:14:37-- 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% 219M=0s 2015-11-23 17:14:37 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.199293 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 17:14:36.331811) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 17:14:36.332139) ========= 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=0ae9de487587ba4b94dd3100000001b5-1448327602.553804-1950711028 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016147 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 17:14:36.385014) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-23 17:14:36.385371) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 19d89caa664dd9309c796929225ee409df5d1ee4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 19d89caa664dd9309c796929225ee409df5d1ee4 --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=0ae9de487587ba4b94dd3100000001b5-1448327602.553804-1950711028 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-23 17:14:37,712 truncating revision to first 12 chars 2015-11-23 17:14:37,712 Setting DEBUG logging. 2015-11-23 17:14:37,712 attempt 1/10 2015-11-23 17:14:37,712 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/19d89caa664d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-23 17:14:38,207 unpacking tar archive at: mozilla-central-19d89caa664d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.776629 ========= master_lag: 1.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-23 17:14:38.201404) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 17:14:38.201697) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 17:14:38.226768) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 17:14:38.227084) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 17:14:38.227480) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2015-11-23 17:14:38.227759) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0ae9de487587ba4b94dd3100000001b5-1448327602.553804-1950711028 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:14:39 INFO - MultiFileLogger online at 20151123 17:14:39 in /builds/slave/test 17:14:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 17:14:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:14:39 INFO - {'append_to_log': False, 17:14:39 INFO - 'base_work_dir': '/builds/slave/test', 17:14:39 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 17:14:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:14:39 INFO - 'branch': 'Firefox-Non-PGO', 17:14:39 INFO - 'buildbot_json_path': 'buildprops.json', 17:14:39 INFO - 'config_files': ('talos/linux_config.py',), 17:14:39 INFO - 'default_actions': ('clobber', 17:14:39 INFO - 'read-buildbot-config', 17:14:39 INFO - 'download-and-extract', 17:14:39 INFO - 'populate-webroot', 17:14:39 INFO - 'create-virtualenv', 17:14:39 INFO - 'install', 17:14:39 INFO - 'run-tests'), 17:14:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:14:39 INFO - 'download_minidump_stackwalk': True, 17:14:39 INFO - 'download_symbols': 'ondemand', 17:14:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:14:39 INFO - 'tooltool.py': '/tools/tooltool.py', 17:14:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:14:39 INFO - '/tools/misc-python/virtualenv.py')}, 17:14:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:14:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:14:39 INFO - 'installer_path': 'installer.exe', 17:14:39 INFO - 'log_level': 'info', 17:14:39 INFO - 'log_name': 'talos', 17:14:39 INFO - 'log_to_console': True, 17:14:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:14:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:14:39 INFO - 'opt_config_files': (), 17:14:39 INFO - 'pip_index': False, 17:14:39 INFO - 'sps_profile': False, 17:14:39 INFO - 'sps_profile_interval': 0, 17:14:39 INFO - 'suite': 'dromaeojs', 17:14:39 INFO - 'system_bits': '64', 17:14:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:14:39 INFO - 'title': 'talos-linux64-ix-056', 17:14:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:14:39 INFO - 'use_talos_json': True, 17:14:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:14:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:14:39 INFO - 'work_dir': 'build'} 17:14:39 INFO - ##### 17:14:39 INFO - ##### Running clobber step. 17:14:39 INFO - ##### 17:14:39 INFO - Running pre-action listener: _resource_record_pre_action 17:14:39 INFO - Running main action method: clobber 17:14:39 INFO - rmtree: /builds/slave/test/build 17:14:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:14:40 INFO - Running post-action listener: _resource_record_post_action 17:14:40 INFO - ##### 17:14:40 INFO - ##### Running read-buildbot-config step. 17:14:40 INFO - ##### 17:14:40 INFO - Running pre-action listener: _resource_record_pre_action 17:14:40 INFO - Running main action method: read_buildbot_config 17:14:40 INFO - Using buildbot properties: 17:14:40 INFO - { 17:14:40 INFO - "properties": { 17:14:40 INFO - "buildnumber": 330, 17:14:40 INFO - "product": "firefox", 17:14:40 INFO - "script_repo_revision": "production", 17:14:40 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 17:14:40 INFO - "repository": "", 17:14:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 17:14:40 INFO - "buildid": "20151123162931", 17:14:40 INFO - "slavename": "talos-linux64-ix-056", 17:14:40 INFO - "pgo_build": "False", 17:14:40 INFO - "basedir": "/builds/slave/test", 17:14:40 INFO - "project": "", 17:14:40 INFO - "platform": "ubuntu64_hw", 17:14:40 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:14:40 INFO - "slavebuilddir": "test", 17:14:40 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 17:14:40 INFO - "branch": "mozilla-central", 17:14:40 INFO - "repo_path": "mozilla-central", 17:14:40 INFO - "stage_platform": "linux64", 17:14:40 INFO - "builduid": "81a1f98460e14c89a33def60e16739b1", 17:14:40 INFO - "revision": "19d89caa664dd9309c796929225ee409df5d1ee4" 17:14:40 INFO - }, 17:14:40 INFO - "sourcestamp": { 17:14:40 INFO - "repository": "", 17:14:40 INFO - "hasPatch": false, 17:14:40 INFO - "project": "", 17:14:40 INFO - "branch": "mozilla-central-linux64-talos", 17:14:40 INFO - "changes": [ 17:14:40 INFO - { 17:14:40 INFO - "category": null, 17:14:40 INFO - "files": [ 17:14:40 INFO - { 17:14:40 INFO - "url": null, 17:14:40 INFO - "name": "https://queue.taskcluster.net/v1/task/vJugx6fcT02MGEw9S8KISA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 17:14:40 INFO - } 17:14:40 INFO - ], 17:14:40 INFO - "repository": "", 17:14:40 INFO - "rev": "19d89caa664dd9309c796929225ee409df5d1ee4", 17:14:40 INFO - "who": "kwierso@gmail.com", 17:14:40 INFO - "when": 1448327669, 17:14:40 INFO - "number": 6698137, 17:14:40 INFO - "comments": "Merge b2ginbound to central, a=merge", 17:14:40 INFO - "project": "", 17:14:40 INFO - "at": "Mon 23 Nov 2015 17:14:29", 17:14:40 INFO - "branch": "mozilla-central-linux64-talos", 17:14:40 INFO - "revlink": "", 17:14:40 INFO - "properties": [ 17:14:40 INFO - [ 17:14:40 INFO - "buildid", 17:14:40 INFO - "20151123162931", 17:14:40 INFO - "Change" 17:14:40 INFO - ], 17:14:40 INFO - [ 17:14:40 INFO - "builduid", 17:14:40 INFO - "81a1f98460e14c89a33def60e16739b1", 17:14:40 INFO - "Change" 17:14:40 INFO - ], 17:14:40 INFO - [ 17:14:40 INFO - "pgo_build", 17:14:40 INFO - "False", 17:14:40 INFO - "Change" 17:14:40 INFO - ] 17:14:40 INFO - ], 17:14:40 INFO - "revision": "19d89caa664dd9309c796929225ee409df5d1ee4" 17:14:40 INFO - } 17:14:40 INFO - ], 17:14:40 INFO - "revision": "19d89caa664dd9309c796929225ee409df5d1ee4" 17:14:40 INFO - } 17:14:40 INFO - } 17:14:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/vJugx6fcT02MGEw9S8KISA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 17:14:40 INFO - Running post-action listener: _resource_record_post_action 17:14:40 INFO - ##### 17:14:40 INFO - ##### Running download-and-extract step. 17:14:40 INFO - ##### 17:14:40 INFO - Running pre-action listener: _resource_record_pre_action 17:14:40 INFO - Running main action method: download_and_extract 17:14:40 INFO - mkdir: /builds/slave/test/build/tests 17:14:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:14:40 INFO - https://queue.taskcluster.net/v1/task/vJugx6fcT02MGEw9S8KISA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 17:14:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vJugx6fcT02MGEw9S8KISA/artifacts/public/build/test_packages.json 17:14:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vJugx6fcT02MGEw9S8KISA/artifacts/public/build/test_packages.json 17:14:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vJugx6fcT02MGEw9S8KISA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 17:14:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vJugx6fcT02MGEw9S8KISA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 17:14:48 INFO - Downloaded 1302 bytes. 17:14:48 INFO - Reading from file /builds/slave/test/build/test_packages.json 17:14:48 INFO - Using the following test package requirements: 17:14:48 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 17:14:48 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:14:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:14:48 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:14:48 INFO - u'jsshell-linux-x86_64.zip'], 17:14:48 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:14:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:14:48 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 17:14:48 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:14:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:14:48 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:14:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:14:48 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:14:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:14:48 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 17:14:48 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:14:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:14:48 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:14:48 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')]} 17:14:48 INFO - https://queue.taskcluster.net/v1/task/vJugx6fcT02MGEw9S8KISA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:14:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vJugx6fcT02MGEw9S8KISA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 17:14:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vJugx6fcT02MGEw9S8KISA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 17:14:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vJugx6fcT02MGEw9S8KISA/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 17:14:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vJugx6fcT02MGEw9S8KISA/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 17:14:59 INFO - Downloaded 21341357 bytes. 17:14:59 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 17:14:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 17:14:59 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 17:15:00 INFO - Return code: 0 17:15:00 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 17:15:00 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')]} 17:15:00 INFO - https://queue.taskcluster.net/v1/task/vJugx6fcT02MGEw9S8KISA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:15:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vJugx6fcT02MGEw9S8KISA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 17:15:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vJugx6fcT02MGEw9S8KISA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 17:15:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vJugx6fcT02MGEw9S8KISA/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 17:15:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vJugx6fcT02MGEw9S8KISA/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 17:15:01 INFO - Downloaded 21341357 bytes. 17:15:01 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 17:15:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 17:15:01 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 17:15:02 INFO - Return code: 0 17:15: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')]} 17:15:02 INFO - https://queue.taskcluster.net/v1/task/vJugx6fcT02MGEw9S8KISA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:15:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vJugx6fcT02MGEw9S8KISA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 17:15:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vJugx6fcT02MGEw9S8KISA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 17:15:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vJugx6fcT02MGEw9S8KISA/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 17:15:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vJugx6fcT02MGEw9S8KISA/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 17:15:03 INFO - Downloaded 11130997 bytes. 17:15:03 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 17:15:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 17:15:03 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 17:15:03 INFO - Return code: 0 17:15:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:03 INFO - https://queue.taskcluster.net/v1/task/vJugx6fcT02MGEw9S8KISA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:15:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vJugx6fcT02MGEw9S8KISA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 17:15:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vJugx6fcT02MGEw9S8KISA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 17:15:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vJugx6fcT02MGEw9S8KISA/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 17:15:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vJugx6fcT02MGEw9S8KISA/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 17:15:06 INFO - Downloaded 56025019 bytes. 17:15:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/vJugx6fcT02MGEw9S8KISA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 17:15:06 INFO - mkdir: /builds/slave/test/properties 17:15:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:15:06 INFO - Writing to file /builds/slave/test/properties/build_url 17:15:06 INFO - Contents: 17:15:06 INFO - build_url:https://queue.taskcluster.net/v1/task/vJugx6fcT02MGEw9S8KISA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 17:15:06 INFO - Running post-action listener: _resource_record_post_action 17:15:06 INFO - Running post-action listener: set_extra_try_arguments 17:15:06 INFO - ##### 17:15:06 INFO - ##### Running populate-webroot step. 17:15:06 INFO - ##### 17:15:06 INFO - Running pre-action listener: _resource_record_pre_action 17:15:06 INFO - Running main action method: populate_webroot 17:15:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:15:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:15:06 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 17:15:06 INFO - '../fennec_ids.txt'], 17:15:06 INFO - 'tests': ['tcheck2']}, 17:15:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:15:06 INFO - '--tppagecycles', 17:15:06 INFO - '7'], 17:15:06 INFO - 'tests': ['tsvgm']}}, 17:15:06 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:15:06 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:15:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:15:06 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:15:06 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:15:06 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:15:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:15:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:06 INFO - 'talos_options': ['--e10s'], 17:15:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:15:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:06 INFO - 'tests': ['damp', 'tps']}, 17:15:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:06 INFO - 'talos_options': ['--e10s'], 17:15:06 INFO - 'tests': ['damp', 'tps']}, 17:15:06 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:15:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:15:06 INFO - 'other': {'tests': ['a11yr', 17:15:06 INFO - 'ts_paint', 17:15:06 INFO - 'tpaint', 17:15:06 INFO - 'sessionrestore', 17:15:06 INFO - 'sessionrestore_no_auto_restore']}, 17:15:06 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:15:06 INFO - 'tests': ['a11yr', 17:15:06 INFO - 'ts_paint', 17:15:06 INFO - 'tpaint', 17:15:06 INFO - 'sessionrestore', 17:15:06 INFO - 'sessionrestore_no_auto_restore']}, 17:15:06 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:15:06 INFO - 'tests': ['a11yr', 17:15:06 INFO - 'ts_paint', 17:15:06 INFO - 'tpaint', 17:15:06 INFO - 'sessionrestore', 17:15:06 INFO - 'sessionrestore_no_auto_restore']}, 17:15:06 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:15:06 INFO - 'tests': ['a11yr', 17:15:06 INFO - 'ts_paint', 17:15:06 INFO - 'tpaint', 17:15:06 INFO - 'sessionrestore', 17:15:06 INFO - 'sessionrestore_no_auto_restore']}, 17:15:06 INFO - 'other_l64': {'tests': ['a11yr', 17:15:06 INFO - 'ts_paint', 17:15:06 INFO - 'tpaint', 17:15:06 INFO - 'sessionrestore', 17:15:06 INFO - 'sessionrestore_no_auto_restore']}, 17:15:06 INFO - 'other_nol64': {'tests': ['a11yr', 17:15:06 INFO - 'ts_paint', 17:15:06 INFO - 'tpaint', 17:15:06 INFO - 'sessionrestore', 17:15:06 INFO - 'sessionrestore_no_auto_restore']}, 17:15:06 INFO - 'svgr': {'tests': ['tsvgx', 17:15:06 INFO - 'tsvgr_opacity', 17:15:06 INFO - 'tart', 17:15:06 INFO - 'tscrollx', 17:15:06 INFO - 'cart']}, 17:15:06 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:15:06 INFO - 'tests': ['tsvgx', 17:15:06 INFO - 'tsvgr_opacity', 17:15:06 INFO - 'tart', 17:15:06 INFO - 'tscrollx', 17:15:06 INFO - 'cart']}, 17:15:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:06 INFO - 'tests': ['tp5o']}, 17:15:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:06 INFO - 'talos_options': ['--e10s'], 17:15:06 INFO - 'tests': ['tp5o']}, 17:15:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:06 INFO - 'talos_options': ['--xperf_path', 17:15:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:15:06 INFO - 'tests': ['tp5n']}, 17:15:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:06 INFO - 'talos_options': ['--e10s', 17:15:06 INFO - '--xperf_path', 17:15:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:15:06 INFO - 'tests': ['tp5n']}}, 17:15:06 INFO - 'talos.zip': {'path': '', 17:15:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:15:06 INFO - Running post-action listener: _resource_record_post_action 17:15:06 INFO - ##### 17:15:06 INFO - ##### Running create-virtualenv step. 17:15:06 INFO - ##### 17:15:06 INFO - Running pre-action listener: _resource_record_pre_action 17:15:06 INFO - Running main action method: create_virtualenv 17:15:06 INFO - Creating virtualenv /builds/slave/test/build/venv 17:15:06 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 17:15:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:15:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:15:06 INFO - Using real prefix '/usr' 17:15:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:15:07 INFO - Installing distribute.............................................................................................................................................................................................done. 17:15:09 INFO - Installing pip.................done. 17:15:09 INFO - Return code: 0 17:15:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:15: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')]} 17:15:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15: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')]} 17:15:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:09 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 0x7f9a2905dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26856c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2736900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277cb70>, '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 0x27cddc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ce250>, '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': '0ae9de487587ba4b94dd3100000001b5-1448327602.553804-1950711028', '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 17:15:09 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 17:15:09 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 17:15:09 INFO - Using env: {'DISPLAY': ':0', 17:15:09 INFO - 'HOME': '/home/cltbld', 17:15:09 INFO - 'LANG': 'en_US.UTF-8', 17:15:09 INFO - 'LANGUAGE': 'en_US:en', 17:15:09 INFO - 'LOGNAME': 'cltbld', 17:15:09 INFO - 'MAIL': '/var/mail/cltbld', 17:15:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:09 INFO - 'MOZ_NO_REMOTE': '1', 17:15:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:09 INFO - 'NO_EM_RESTART': '1', 17:15:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:09 INFO - 'PWD': '/builds/slave/test', 17:15:09 INFO - 'SHELL': '/bin/bash', 17:15:09 INFO - 'SHLVL': '1', 17:15:09 INFO - 'TERM': 'linux', 17:15:09 INFO - 'TMOUT': '86400', 17:15:09 INFO - 'USER': 'cltbld', 17:15:09 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1448327602.553804-1950711028', 17:15:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:09 INFO - '_': '/tools/buildbot/bin/python'} 17:15:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:09 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 17:15:09 INFO - Cleaning up... 17:15:09 INFO - Return code: 0 17:15:09 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:15: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')]} 17:15:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15: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')]} 17:15:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:09 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 0x7f9a2905dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26856c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2736900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277cb70>, '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 0x27cddc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ce250>, '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': '0ae9de487587ba4b94dd3100000001b5-1448327602.553804-1950711028', '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 17:15:09 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 17:15:09 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 17:15:09 INFO - Using env: {'DISPLAY': ':0', 17:15:09 INFO - 'HOME': '/home/cltbld', 17:15:09 INFO - 'LANG': 'en_US.UTF-8', 17:15:09 INFO - 'LANGUAGE': 'en_US:en', 17:15:09 INFO - 'LOGNAME': 'cltbld', 17:15:09 INFO - 'MAIL': '/var/mail/cltbld', 17:15:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:09 INFO - 'MOZ_NO_REMOTE': '1', 17:15:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:09 INFO - 'NO_EM_RESTART': '1', 17:15:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:09 INFO - 'PWD': '/builds/slave/test', 17:15:09 INFO - 'SHELL': '/bin/bash', 17:15:09 INFO - 'SHLVL': '1', 17:15:09 INFO - 'TERM': 'linux', 17:15:09 INFO - 'TMOUT': '86400', 17:15:09 INFO - 'USER': 'cltbld', 17:15:09 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1448327602.553804-1950711028', 17:15:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:09 INFO - '_': '/tools/buildbot/bin/python'} 17:15:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:09 INFO - Downloading/unpacking psutil>=0.7.1 17:15:09 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 17:15:09 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 17:15:09 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 17:15:09 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 17:15:09 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 17:15:09 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 17:15:11 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 17:15:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 17:15:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:15:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:15:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:15:11 INFO - Installing collected packages: psutil 17:15:11 INFO - Running setup.py install for psutil 17:15:11 INFO - building 'psutil._psutil_linux' extension 17:15:11 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 17:15:11 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 17:15:11 INFO - building 'psutil._psutil_posix' extension 17:15:11 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 17:15:11 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 17:15:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:15:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:15:12 INFO - Successfully installed psutil 17:15:12 INFO - Cleaning up... 17:15:12 INFO - Return code: 0 17:15:12 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:15:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7f9a2905dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26856c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2736900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277cb70>, '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 0x27cddc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ce250>, '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': '0ae9de487587ba4b94dd3100000001b5-1448327602.553804-1950711028', '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 17:15:12 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 17:15:12 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 17:15:12 INFO - Using env: {'DISPLAY': ':0', 17:15:12 INFO - 'HOME': '/home/cltbld', 17:15:12 INFO - 'LANG': 'en_US.UTF-8', 17:15:12 INFO - 'LANGUAGE': 'en_US:en', 17:15:12 INFO - 'LOGNAME': 'cltbld', 17:15:12 INFO - 'MAIL': '/var/mail/cltbld', 17:15:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:12 INFO - 'MOZ_NO_REMOTE': '1', 17:15:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:12 INFO - 'NO_EM_RESTART': '1', 17:15:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:12 INFO - 'PWD': '/builds/slave/test', 17:15:12 INFO - 'SHELL': '/bin/bash', 17:15:12 INFO - 'SHLVL': '1', 17:15:12 INFO - 'TERM': 'linux', 17:15:12 INFO - 'TMOUT': '86400', 17:15:12 INFO - 'USER': 'cltbld', 17:15:12 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1448327602.553804-1950711028', 17:15:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:12 INFO - '_': '/tools/buildbot/bin/python'} 17:15:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:12 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:15:12 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 17:15:12 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 17:15:12 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 17:15:12 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 17:15:12 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 17:15:12 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 17:15:13 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:15:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 17:15:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:15:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:15:14 INFO - Installing collected packages: mozsystemmonitor 17:15:14 INFO - Running setup.py install for mozsystemmonitor 17:15:14 INFO - Successfully installed mozsystemmonitor 17:15:14 INFO - Cleaning up... 17:15:14 INFO - Return code: 0 17:15:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:15:14 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')]} 17:15:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:14 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')]} 17:15:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:14 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 0x7f9a2905dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26856c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2736900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277cb70>, '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 0x27cddc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ce250>, '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': '0ae9de487587ba4b94dd3100000001b5-1448327602.553804-1950711028', '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 17:15:14 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 17:15:14 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 17:15:14 INFO - Using env: {'DISPLAY': ':0', 17:15:14 INFO - 'HOME': '/home/cltbld', 17:15:14 INFO - 'LANG': 'en_US.UTF-8', 17:15:14 INFO - 'LANGUAGE': 'en_US:en', 17:15:14 INFO - 'LOGNAME': 'cltbld', 17:15:14 INFO - 'MAIL': '/var/mail/cltbld', 17:15:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:14 INFO - 'MOZ_NO_REMOTE': '1', 17:15:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:14 INFO - 'NO_EM_RESTART': '1', 17:15:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:14 INFO - 'PWD': '/builds/slave/test', 17:15:14 INFO - 'SHELL': '/bin/bash', 17:15:14 INFO - 'SHLVL': '1', 17:15:14 INFO - 'TERM': 'linux', 17:15:14 INFO - 'TMOUT': '86400', 17:15:14 INFO - 'USER': 'cltbld', 17:15:14 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1448327602.553804-1950711028', 17:15:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:14 INFO - '_': '/tools/buildbot/bin/python'} 17:15:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:14 INFO - Downloading/unpacking blobuploader==1.2.4 17:15: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 17:15: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 17:15: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 17:15: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 17:15: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 17:15: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 17:15:16 INFO - Downloading blobuploader-1.2.4.tar.gz 17:15:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 17:15:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:15:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:15:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:15:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:15:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 17:15:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:15:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:15:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:15:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:15:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:16 INFO - Downloading docopt-0.6.1.tar.gz 17:15:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 17:15:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:15:16 INFO - Installing collected packages: blobuploader, requests, docopt 17:15:16 INFO - Running setup.py install for blobuploader 17:15:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:15:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:15:16 INFO - Running setup.py install for requests 17:15:17 INFO - Running setup.py install for docopt 17:15:17 INFO - Successfully installed blobuploader requests docopt 17:15:17 INFO - Cleaning up... 17:15:17 INFO - Return code: 0 17:15:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:15:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:17 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 0x7f9a2905dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26856c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2736900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277cb70>, '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 0x27cddc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ce250>, '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': '0ae9de487587ba4b94dd3100000001b5-1448327602.553804-1950711028', '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 17:15:17 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 17:15:17 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 17:15:17 INFO - Using env: {'DISPLAY': ':0', 17:15:17 INFO - 'HOME': '/home/cltbld', 17:15:17 INFO - 'LANG': 'en_US.UTF-8', 17:15:17 INFO - 'LANGUAGE': 'en_US:en', 17:15:17 INFO - 'LOGNAME': 'cltbld', 17:15:17 INFO - 'MAIL': '/var/mail/cltbld', 17:15:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:17 INFO - 'MOZ_NO_REMOTE': '1', 17:15:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:17 INFO - 'NO_EM_RESTART': '1', 17:15:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:17 INFO - 'PWD': '/builds/slave/test', 17:15:17 INFO - 'SHELL': '/bin/bash', 17:15:17 INFO - 'SHLVL': '1', 17:15:17 INFO - 'TERM': 'linux', 17:15:17 INFO - 'TMOUT': '86400', 17:15:17 INFO - 'USER': 'cltbld', 17:15:17 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1448327602.553804-1950711028', 17:15:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:17 INFO - '_': '/tools/buildbot/bin/python'} 17:15:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:15:17 INFO - Running setup.py (path:/tmp/pip-hvu1An-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:15:17 INFO - Running setup.py (path:/tmp/pip-VTabco-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:15:17 INFO - Running setup.py (path:/tmp/pip-LUqfvk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:15:17 INFO - Running setup.py (path:/tmp/pip-2tzqSi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:15:17 INFO - Running setup.py (path:/tmp/pip-KMG3qp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:15:17 INFO - Running setup.py (path:/tmp/pip-a_Da9S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:15:18 INFO - Running setup.py (path:/tmp/pip-ObM0xu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:15:18 INFO - Running setup.py (path:/tmp/pip-P1DxNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:15:18 INFO - Running setup.py (path:/tmp/pip-emNzqy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:15:18 INFO - Running setup.py (path:/tmp/pip-B0Vu2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:15:18 INFO - Running setup.py (path:/tmp/pip-meL7ng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:15:18 INFO - Running setup.py (path:/tmp/pip-PfHWQ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:15:18 INFO - Running setup.py (path:/tmp/pip-sTrhGl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:15:18 INFO - Running setup.py (path:/tmp/pip-h3_82C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:15:18 INFO - Running setup.py (path:/tmp/pip-ZL3Ncx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:15:18 INFO - Running setup.py (path:/tmp/pip-OFTmdZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:15:18 INFO - Running setup.py (path:/tmp/pip-exeINL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:15:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:15:18 INFO - Running setup.py install for manifestparser 17:15:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:15:18 INFO - Running setup.py install for mozcrash 17:15:19 INFO - Running setup.py install for mozdebug 17:15:19 INFO - Running setup.py install for mozdevice 17:15:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:15:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:15:19 INFO - Running setup.py install for mozfile 17:15:19 INFO - Running setup.py install for mozhttpd 17:15:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:15:19 INFO - Running setup.py install for mozinfo 17:15:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:15:19 INFO - Running setup.py install for mozInstall 17:15:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:15:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:15:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:15:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:15:19 INFO - Running setup.py install for mozleak 17:15:19 INFO - Running setup.py install for mozlog 17:15:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:15:19 INFO - Running setup.py install for moznetwork 17:15:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:15:19 INFO - Running setup.py install for mozprocess 17:15:20 INFO - Running setup.py install for mozprofile 17:15:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:15:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:15:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:15:20 INFO - Running setup.py install for mozrunner 17:15:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:15:20 INFO - Running setup.py install for mozscreenshot 17:15:20 INFO - Running setup.py install for moztest 17:15:20 INFO - Running setup.py install for mozversion 17:15:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:15:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:15:20 INFO - Cleaning up... 17:15:20 INFO - Return code: 0 17:15:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:15:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:20 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 0x7f9a2905dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26856c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2736900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277cb70>, '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 0x27cddc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ce250>, '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': '0ae9de487587ba4b94dd3100000001b5-1448327602.553804-1950711028', '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 17:15:20 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 17:15:20 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 17:15:20 INFO - Using env: {'DISPLAY': ':0', 17:15:20 INFO - 'HOME': '/home/cltbld', 17:15:20 INFO - 'LANG': 'en_US.UTF-8', 17:15:20 INFO - 'LANGUAGE': 'en_US:en', 17:15:20 INFO - 'LOGNAME': 'cltbld', 17:15:20 INFO - 'MAIL': '/var/mail/cltbld', 17:15:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:20 INFO - 'MOZ_NO_REMOTE': '1', 17:15:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:20 INFO - 'NO_EM_RESTART': '1', 17:15:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:20 INFO - 'PWD': '/builds/slave/test', 17:15:20 INFO - 'SHELL': '/bin/bash', 17:15:20 INFO - 'SHLVL': '1', 17:15:20 INFO - 'TERM': 'linux', 17:15:20 INFO - 'TMOUT': '86400', 17:15:20 INFO - 'USER': 'cltbld', 17:15:20 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1448327602.553804-1950711028', 17:15:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:20 INFO - '_': '/tools/buildbot/bin/python'} 17:15:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:15:20 INFO - Running setup.py (path:/tmp/pip-O0OTV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:15:20 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)) 17:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:15:20 INFO - Running setup.py (path:/tmp/pip-iTYEOr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:15:20 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)) 17:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:15:20 INFO - Running setup.py (path:/tmp/pip-GkaMqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:15:21 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)) 17:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:15:21 INFO - Running setup.py (path:/tmp/pip-En8Enp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:15:21 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)) 17:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:15:21 INFO - Running setup.py (path:/tmp/pip-d9SlL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:15:21 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)) 17:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:15:21 INFO - Running setup.py (path:/tmp/pip-wtELzv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:15:21 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)) 17:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:15:21 INFO - Running setup.py (path:/tmp/pip-mATi_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:15:21 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)) 17:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:15:21 INFO - Running setup.py (path:/tmp/pip-actIyL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:15:21 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)) 17:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:15:21 INFO - Running setup.py (path:/tmp/pip-Ww7OeP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:15:21 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)) 17:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:15:21 INFO - Running setup.py (path:/tmp/pip-BXCWoF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:15:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:15:21 INFO - Running setup.py (path:/tmp/pip-75E1Q8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:15:21 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)) 17:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:15:21 INFO - Running setup.py (path:/tmp/pip-nVU48d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:15:21 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)) 17:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:15:21 INFO - Running setup.py (path:/tmp/pip-K4Itc3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:15:21 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)) 17:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:15:21 INFO - Running setup.py (path:/tmp/pip-q5zJAH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:15:21 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)) 17:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:15:21 INFO - Running setup.py (path:/tmp/pip-NHPHPR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:15:21 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)) 17:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:15:21 INFO - Running setup.py (path:/tmp/pip-nkXxqw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:15:21 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)) 17:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:15:21 INFO - Running setup.py (path:/tmp/pip-4qxLiq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:15:22 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)) 17:15:22 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)) 17:15:22 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)) 17:15:22 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)) 17:15:22 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)) 17:15:22 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)) 17:15:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:15:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:15:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:15:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:23 INFO - Downloading blessings-1.5.1.tar.gz 17:15:23 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 17:15:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:15:23 INFO - Installing collected packages: blessings 17:15:23 INFO - Running setup.py install for blessings 17:15:24 INFO - Successfully installed blessings 17:15:24 INFO - Cleaning up... 17:15:24 INFO - Return code: 0 17:15:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:15:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:15:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:15:24 INFO - Reading from file tmpfile_stdout 17:15:24 INFO - Current package versions: 17:15:24 INFO - argparse == 1.2.1 17:15:24 INFO - blessings == 1.5.1 17:15:24 INFO - blobuploader == 1.2.4 17:15:24 INFO - docopt == 0.6.1 17:15:24 INFO - manifestparser == 1.1 17:15:24 INFO - mozInstall == 1.12 17:15:24 INFO - mozcrash == 0.16 17:15:24 INFO - mozdebug == 0.1 17:15:24 INFO - mozdevice == 0.47 17:15:24 INFO - mozfile == 1.2 17:15:24 INFO - mozhttpd == 0.7 17:15:24 INFO - mozinfo == 0.9 17:15:24 INFO - mozleak == 0.1 17:15:24 INFO - mozlog == 3.1 17:15:24 INFO - moznetwork == 0.27 17:15:24 INFO - mozprocess == 0.22 17:15:24 INFO - mozprofile == 0.27 17:15:24 INFO - mozrunner == 6.11 17:15:24 INFO - mozscreenshot == 0.1 17:15:24 INFO - mozsystemmonitor == 0.0 17:15:24 INFO - moztest == 0.7 17:15:24 INFO - mozversion == 1.4 17:15:24 INFO - psutil == 3.1.1 17:15:24 INFO - requests == 1.2.3 17:15:24 INFO - wsgiref == 0.1.2 17:15:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:15:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:24 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 0x7f9a2905dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26856c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2736900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277cb70>, '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 0x27cddc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ce250>, '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': '0ae9de487587ba4b94dd3100000001b5-1448327602.553804-1950711028', '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 17:15:24 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 17:15:24 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 17:15:24 INFO - Using env: {'DISPLAY': ':0', 17:15:24 INFO - 'HOME': '/home/cltbld', 17:15:24 INFO - 'LANG': 'en_US.UTF-8', 17:15:24 INFO - 'LANGUAGE': 'en_US:en', 17:15:24 INFO - 'LOGNAME': 'cltbld', 17:15:24 INFO - 'MAIL': '/var/mail/cltbld', 17:15:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:24 INFO - 'MOZ_NO_REMOTE': '1', 17:15:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:24 INFO - 'NO_EM_RESTART': '1', 17:15:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:24 INFO - 'PWD': '/builds/slave/test', 17:15:24 INFO - 'SHELL': '/bin/bash', 17:15:24 INFO - 'SHLVL': '1', 17:15:24 INFO - 'TERM': 'linux', 17:15:24 INFO - 'TMOUT': '86400', 17:15:24 INFO - 'USER': 'cltbld', 17:15:24 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1448327602.553804-1950711028', 17:15:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:24 INFO - '_': '/tools/buildbot/bin/python'} 17:15:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:24 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)) 17:15:24 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)) 17:15:24 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)) 17:15:24 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)) 17:15:24 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)) 17:15:24 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)) 17:15:24 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)) 17:15:24 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)) 17:15:24 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)) 17:15:24 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)) 17:15:24 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)) 17:15:24 INFO - Cleaning up... 17:15:24 INFO - Return code: 0 17:15:24 INFO - Running post-action listener: _resource_record_post_action 17:15:24 INFO - Running post-action listener: _start_resource_monitoring 17:15:24 INFO - Starting resource monitoring. 17:15:24 INFO - ##### 17:15:24 INFO - ##### Running install step. 17:15:24 INFO - ##### 17:15:24 INFO - Running pre-action listener: _resource_record_pre_action 17:15:24 INFO - Running main action method: install 17:15:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:15:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:15:24 INFO - Reading from file tmpfile_stdout 17:15:24 INFO - Detecting whether we're running mozinstall >=1.0... 17:15:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:15:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:15:24 INFO - Reading from file tmpfile_stdout 17:15:24 INFO - Output received: 17:15:24 INFO - Usage: mozinstall [options] installer 17:15:24 INFO - Options: 17:15:24 INFO - -h, --help show this help message and exit 17:15:24 INFO - -d DEST, --destination=DEST 17:15:24 INFO - Directory to install application into. [default: 17:15:24 INFO - "/builds/slave/test"] 17:15:24 INFO - --app=APP Application being installed. [default: firefox] 17:15:24 INFO - mkdir: /builds/slave/test/build/application 17:15:24 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'] 17:15:24 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 17:15:39 INFO - Reading from file tmpfile_stdout 17:15:39 INFO - Output received: 17:15:39 INFO - /builds/slave/test/build/application/firefox/firefox 17:15:39 INFO - Running post-action listener: _resource_record_post_action 17:15:39 INFO - ##### 17:15:39 INFO - ##### Running run-tests step. 17:15:39 INFO - ##### 17:15:39 INFO - Running pre-action listener: _resource_record_pre_action 17:15:39 INFO - Running main action method: run_tests 17:15:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:15:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:15:39 INFO - Python 2.7.3 17:15:39 INFO - Return code: 0 17:15:39 INFO - grabbing minidump binary from tooltool 17:15:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:39 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 0x277cb70>, '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 0x27cddc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ce250>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:15:39 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 17:15:39 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 17:15:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:15:39 INFO - Return code: 0 17:15:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:15:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:15:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:15:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:15:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:15:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/vJugx6fcT02MGEw9S8KISA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost'] in /builds/slave/test/build 17:15:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/vJugx6fcT02MGEw9S8KISA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --webServer localhost 17:15:39 INFO - Using env: {'DISPLAY': ':0', 17:15:39 INFO - 'HOME': '/home/cltbld', 17:15:39 INFO - 'LANG': 'en_US.UTF-8', 17:15:39 INFO - 'LANGUAGE': 'en_US:en', 17:15:39 INFO - 'LOGNAME': 'cltbld', 17:15:39 INFO - 'MAIL': '/var/mail/cltbld', 17:15:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:15:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:15:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:39 INFO - 'MOZ_NO_REMOTE': '1', 17:15:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:15:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:39 INFO - 'NO_EM_RESTART': '1', 17:15:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:39 INFO - 'PWD': '/builds/slave/test', 17:15:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:15:39 INFO - 'SHELL': '/bin/bash', 17:15:39 INFO - 'SHLVL': '1', 17:15:39 INFO - 'TERM': 'linux', 17:15:39 INFO - 'TMOUT': '86400', 17:15:39 INFO - 'USER': 'cltbld', 17:15:39 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1448327602.553804-1950711028', 17:15:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:39 INFO - '_': '/tools/buildbot/bin/python'} 17:15:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/vJugx6fcT02MGEw9S8KISA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost'] with output_timeout 3600 17:15:39 INFO - mozversion INFO | application_buildid: 20151123162931 17:15:39 INFO - mozversion INFO | application_changeset: 19d89caa664dd9309c796929225ee409df5d1ee4 17:15:39 INFO - mozversion INFO | application_display_name: Nightly 17:15:39 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:15:39 INFO - mozversion INFO | application_name: Firefox 17:15:39 INFO - mozversion INFO | application_remotingname: firefox 17:15:39 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 17:15:39 INFO - mozversion INFO | application_vendor: Mozilla 17:15:39 INFO - mozversion INFO | application_version: 45.0a1 17:15:39 INFO - mozversion INFO | platform_buildid: 20151123162931 17:15:39 INFO - mozversion INFO | platform_changeset: 19d89caa664dd9309c796929225ee409df5d1ee4 17:15:39 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 17:15:39 INFO - mozversion INFO | platform_version: 45.0a1 17:15:39 INFO - 2015-11-23 17:15:39,297 DEBUG : using testdate: 1448327739 17:15:39 INFO - 2015-11-23 17:15:39,297 DEBUG : actual date: 1448327739 17:15:39 INFO - 2015-11-23 17:15:39,387 INFO : starting webserver on 'localhost:46747' 17:15:39 INFO - 2015-11-23 17:15:39,388 INFO : Starting test suite talos-linux64-ix-056 17:15:39 INFO - 2015-11-23 17:15:39,388 INFO : Starting test dromaeo_css 17:15:39 INFO - 2015-11-23 17:15:39,388 DEBUG : operating with platform_type : linux_ 17:15:39 INFO - 2015-11-23 17:15:39,389 INFO : Initialising browser for dromaeo_css test... 17:15:39 INFO - 2015-11-23 17:15:39,405 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpp88Oig/profile http://localhost:46747/getInfo.html 17:15:44 INFO - 2015-11-23 17:15:44,228 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:15:44 INFO - 2015-11-23 17:15:44,228 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:15:44 INFO - 2015-11-23 17:15:44,228 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 17:15:44 INFO - 2015-11-23 17:15:44,228 DEBUG : BROWSER_OUTPUT: __metrics 17:15:44 INFO - 2015-11-23 17:15:44,438 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:15:45 INFO - 2015-11-23 17:15:45,925 INFO : Browser initialized. 17:15:45 INFO - 2015-11-23 17:15:45,926 INFO : Running cycle 1/1 for dromaeo_css test... 17:15:45 INFO - 2015-11-23 17:15:45,926 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpp88Oig/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:15:57 INFO - 2015-11-23 17:15:57,826 DEBUG : BROWSER_OUTPUT: RSS: Main: 142176256 17:15:57 INFO - 2015-11-23 17:15:57,826 DEBUG : BROWSER_OUTPUT: 17:16:49 INFO - 2015-11-23 17:16:49,238 DEBUG : BROWSER_OUTPUT: 1448327809235 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] 17:19:01 INFO - 2015-11-23 17:19:01,612 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46747/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46747/tests/dromaeo/cssquery-ext.html) 17:19:02 INFO - 2015-11-23 17:19:02,697 DEBUG : BROWSER_OUTPUT: RSS: Main: 239067136 17:19:02 INFO - 2015-11-23 17:19:02,697 DEBUG : BROWSER_OUTPUT: 17:22:05 INFO - 2015-11-23 17:22:05,245 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46747/tests/dromaeo/cssquery-ext.html (next: http://localhost:46747/tests/dromaeo/cssquery-jquery.html) 17:22:05 INFO - 2015-11-23 17:22:05,814 DEBUG : BROWSER_OUTPUT: RSS: Main: 214859776 17:22:05 INFO - 2015-11-23 17:22:05,814 DEBUG : BROWSER_OUTPUT: 17:25:07 INFO - 2015-11-23 17:25:07,884 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46747/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46747/tests/dromaeo/cssquery-mootools.html) 17:25:08 INFO - 2015-11-23 17:25:08,453 DEBUG : BROWSER_OUTPUT: RSS: Main: 210169856 17:25:08 INFO - 2015-11-23 17:25:08,453 DEBUG : BROWSER_OUTPUT: 17:28:10 INFO - 2015-11-23 17:28:10,359 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46747/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46747/tests/dromaeo/cssquery-prototype.html) 17:28:10 INFO - 2015-11-23 17:28:10,928 DEBUG : BROWSER_OUTPUT: RSS: Main: 200302592 17:28:10 INFO - 2015-11-23 17:28:10,928 DEBUG : BROWSER_OUTPUT: 17:31:13 INFO - 2015-11-23 17:31:13,697 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46747/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46747/tests/dromaeo/cssquery-yui.html) 17:31:14 INFO - 2015-11-23 17:31:14,278 DEBUG : BROWSER_OUTPUT: RSS: Main: 200765440 17:31:14 INFO - 2015-11-23 17:31:14,278 DEBUG : BROWSER_OUTPUT: 17:34:16 INFO - 2015-11-23 17:34:16,671 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46747/tests/dromaeo/cssquery-yui.html (next: http://localhost:46747/tests/dromaeo/cssquery-dojo.html) 17:34:16 INFO - 2015-11-23 17:34:16,929 DEBUG : BROWSER_OUTPUT: RSS: Main: 249737216 17:34:16 INFO - 2015-11-23 17:34:16,929 DEBUG : BROWSER_OUTPUT: 17:34:16 INFO - 2015-11-23 17:34:16,929 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:34:16 INFO - 2015-11-23 17:34:16,929 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:34:16 INFO - 2015-11-23 17:34:16,929 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:34:16 INFO - 2015-11-23 17:34:16,929 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:34:16 INFO - 2015-11-23 17:34:16,929 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2616.2805228562147;2677.5180467515866;2680.5845094010433;2694.9893789828825;2717.646705928229;4519.615832654228;4635.466921304051;4648.860534183971;4656.324832899232;4666.206744853374;4582.541745825416;4626.676132670715;4673.485916549185;4690.882727931804;4817.205161148407;4285.250081235787;4298.957010429887;4303.397524346594;4326.480822301328;4338.023944612469;4090.6318431341174;4338.392625032498;4353.608175264226;4399.472063352402;4409.272470042439;4192.24539582875;4216.873493795191;4250.553691862341;4350.564943505656;4392.099619577979;4337.132573485315;4337.1976184405985;4344.978275108636;4358.629516491071;4380.102079073814;4298.527162012176;4313.072689371768;4318.1363727254675;4348.782560871975;4357.433533640607;4413.3821265022925;4479.641628669699;4494.7977341019405;4531.365608814768;4539.523350048264;5021.748912554358;5054.267131265946;5055.191169412913;5055.873603159914;5059.316992206079;5015.122353588107;5082.415522214956;5099.413567439755;5128.820491282824;5129.12804823181;4555.977220113945;4674.462436819741;4684.882877928011;4686.367340409035;4723.48041715411;4994.0511302853065;5027.245913113063;5037.29477873098;5046.091703493406;5072.695638261643;4856.635752318591;4858.198397264482;4868.902621947541;4868.9756551217015;4907.754612269372;4819.566239038433;4914.557689807934;4921.188003979375;4971.328870602495;5024.171011783088;4939.53074457926;5013.523715247045;5036.445990940993;5038.269450929594;5099.413567439792;4927.630427717935;4931.876703082452;4931.9753401232765;4932.53140951609;4978.800847966113;4011.0574015106426;4058.1477889643506;4100.65144462724;4185.039526476788;4204.07510347723;3594.892153235407;3623.3115708015393;3667.94498082529;3669.2661467706566;3694.390425579803;4371.475422949266;4396.868093957187;4397.802098905557;4408.184485870061;4432.889177770581;4838.177509823338;4936.703797772145;5079.390473143247;5091.287219789232;5136.820211292662;4268.850590229327;4281.785910704452;4353.325234588644;4364.279893817485;4370.950971766817;4430.689851710349;4431.734095954189;4439.600435960779;4446.044100518404;4476.082403107355;4766.45185803637;4770.54679805411;4770.9980904010545;4771.880702982453;4809.927851082237;4830.347903033045;4887.095887260868;4949.480304567968;4953.108440480748;5000.274960130833;4785.138675038526;4808.831690890802;4816.783244754065;4823.421189457287;4858.732769697701;4990.925136122888;4991.575716064175;4993.550580447777;4996.275540046746;5026.572741317029;4792.904141917212;4885.682430641997;4907.9263811043575;4914.0908931847725;4986.975065124651;4884.609231261419;4915.852524424273;4927.827526036572;4930;4957.925631115609;4899.069176856386;4914.950850491592;4920.360353154067;4921.655484116078;4960.20636698141;4544.295634176708;4646.303054541846;4733.810647574059;4744.691595046311;4745.6203503718925;4739.241721324572;4964.8758781030765;4966.900661986812;4969.180085285887;4971.030649023406;4854.150523658275;4854.344663470528;4854.514548545118;4854.635902307412;4856.1987272099705 17:34:16 INFO - 2015-11-23 17:34:16,929 DEBUG : BROWSER_OUTPUT: |1;ext.html;543.3371287029823;553.8947599956008;555.9777608895645;562.2522045679247;575.5855783835636;25207.49585008299;25924.87037564814;36747.448788268164;37532.43701344475;37538.624613753855;39558.802205989;40187.19625607486;40238.59761402385;40263.19473610526;40286.19427611446;6809.59142451452;7012.719491220345;7911.841763164748;8023.077346105185;8089.150639182889;10152.492375381238;10407.37555746654;10421;10436.582536698523;10439.686809395731;10022.098011178992;10115.848262276071;10125.645602403918;10130.240231982594;10136.797264054714;6851.246362900102;7036.577805331645;10025.54885030168;10031;10251.84622230667;9751.3661611995;9886.80226395468;9913.603455861758;9926.057024582726;9940.25448091396;36908.077298067496;37413;37477.25045499102;37499.4375084374;37574.43638345427;2749.312671832042;2758.213909035915;2782.721727827201;2797.202797202787;2823.520001599733;27689.723102769116;27794.386729725207;27847.303817404525;28100.578491322645;28561.85719071412;3379.8310084495924;3523.453864650983;3564.108972756811;3568.7858728476376;3717.3866312058476;223689;226305;226651;226863;227277;40303.39544906829;40759;54819.725901370235;55818.44181558213;56879;51431;51468.48531514712;51728.74135629298;51855.48144518582;51857.48142518602;13621.795673064911;13816.447342106203;13818.37817298224;13830.23933683637;13831.723365532835;10539.051485366354;10606.734831629272;10612.734681633021;10619.150467962545;10735.194860385502;18662.906685466485;18733.81266187348;18779.624407512045;18800.34198803035;18815;7504.362129219077;7711.18296443253;7744.380449564022;7929.841403172019;7948.721794737156;870.4385671242013;884.5002573546054;916.0564618443015;946.6923249943795;949.2168960607527;25942.481150377265;26132.608010879852;26257.343566410993;26371.868140659557;26516.337091572866;936.878205833251;957.4638202606424;960.3229723045237;968.3076600230869;1029.0584115534202;13856.237906915216;13862.168269903837;13891.722165556632;14029.719405612035;14990.175540345168;317968;323296;323926;326014;326184;48719;48929;49089.263661045115;49136.75431622891;49213.753931230116;1197.6466942252057;1217.5555922088552;1227.699213692651;1229.5450683247257;1241.0567968343944;26495;27306.726932730417;27401.58897616577;27949.301267468476;27961.16116516508;39226;39690;39715.2056958865;39718;39749;240244;242450;290168;295965;305813;28536.85731571329;28732.71267287384;28757;29015.419691606472;29220.7077929218;36874;37772.62227377691;37964.893169269504;38359.80820095882;38361.61638383692;22228.444288892908;32040.198995025312;32543.51184732278;32621.673783262813;33066.7013288271;24510.264692059267;29199;29232.41535169327;29350.41299174047;37170.6282937178;33713.494297585064;34131.317373652884;34324.14189645279;34491;34847;30138.69861301359;31114;31335.68664313328;31755;31806.204844879063;24520.386990325384;24542;24658.260252192464;24835.379115522257;25032.874835625706 17:34:16 INFO - 2015-11-23 17:34:16,929 DEBUG : BROWSER_OUTPUT: |2;jquery.html;330.86434561829657;332.6424094098844;336.9780964237325;337.1100295220618;337.1840146844636;14955;15334.38662453502;15428.305726242304;16078.356865725385;16081.758773618376;9983.800323993515;13380;13616.931915340434;13635.181889086662;13669.93165034176;4379.5182529921685;4507.278835386339;4512.9097418051615;4515.367848501212;4515.61617262533;4490.775461226942;4525.592696657301;4530.592246697796;4536.77316134192;4548.5224051474615;2982.075556577457;3070.140360699008;4525.660575456837;4691.225947718623;4895.730734809584;4986.9750651246695;4992.950070499285;5005.6996580205305;5023.899522009558;5036.4208116066575;4755.476897541268;4808.278758186265;4826.227803551415;4831.371921650198;4916.53292937174;9394.34239603228;9622.663206787729;9723.319367644268;10007.399556026661;10053.346532475365;1775.9200835962413;1779.9288028478845;1824.5438640339914;1836.40316897009;1844.0687452836366;8484.78788030298;8570.528620925847;8660.956695216484;8923.15230053144;8998.86501702475;1706.8890522116023;1736.6353065856185;1770.0972504022911;1771.503978885914;1772.8049914509393;51471.22793158068;52424.47575524234;53827.73086134584;54256.186157207674;54633.9999999996;9276.257899368034;9411.576479058458;9424.670136545188;9449.669261575811;9512.90487095134;11881.22772019816;11912;11941.64175074749;11954.52181912731;11970.58102966392;6943.756968506078;6992.440604751608;7001.684924178424;7014.298570143047;7125.89311160333;6668.799936001928;6682.498812588978;6696.497762667819;6726.058351830748;6727.66361681914;3964.801759911993;4030.2544029354663;4031.3952907064177;4038.5355684096703;4076.673866090765;1630.7146249406544;1647.6045749020388;1669.0569828047358;1679.8320167983104;1695.788026496688;642.3929386729495;817.3869597801648;879.7536689726886;880.308957468397;887.4763889305211;13026.41381137851;14900.925495372454;15807.288672009787;16244.269007894673;16339.918300408659;801.7474495533888;821.168334561796;860.6944534690094;910.5128756115447;933.5145724223502;8327.292180164754;8386.706465273808;8688.609012594448;8693.391462597683;8830.205281524693;508451;510014;516812;517260;518347;39699;50214;51626.48373516217;65968.67015664987;68782.65608671925;1074.3178081918038;1075.102289588187;1114.637742733615;1133.971650708739;1137.8748337682848;14056.226907520184;14530.782038269223;14568.562943111723;14685.192314422382;14859.628509286922;30365.240868978453;31119.68880311168;31990.84004579962;32704.182395440304;32759.344813104082;40106.59893401029;42036.36945445882;42273.365899510914;42672.78663606662;43215.56784432115;8219.178082191973;8707.129287071495;8912.019677835304;8934.597943092707;8942.016378198523;9943.701688949342;9958.053984871425;10001.849972250277;10017.098461138532;10089;11817.763644727229;13564.897440896677;13772.655683607589;13884.444622215402;14266.857331426552;12822.422990965242;12964.638712935006;13637.318134093453;13825.239611821446;13969.30153492301;13402.17980669251;13443.46226150943;13551.796723048965;13611.795823062464;13977;8409.83180336402;8451.746447606582;8681.392302538761;8701.17338852808;8711.78220544466;12090.214136081127;12240.143189976972;12465.065120116209;12617.242965422103;12838.55065072718 17:34:16 INFO - 2015-11-23 17:34:16,931 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1087.5106202209008;1356.6879617687932;1417.54638515675;1489.218160465756;1673.6067024249307;5813.098969659704;6451.258105317884;6629.138212032429;6637.170353705781;6661.533692641517;6550.246721627014;6573.638449885254;6653;6676.76631317904;6691.933080669191;1945.4649971257911;2004.8496362772778;2006.2877678424168;2006.5585571174317;2008.5079155606898;2014.264793350431;2015.3550863723615;2027.7262569553143;2045.2125931516325;2054.3426103646766;1971.4775584470055;1986.9403917882414;2002.879827210372;2004.4187185716125;2005.5487515309085;2020.3433883987689;2028.3914825552276;2031.1164643380102;2032.7154198412309;2034.4201902457728;1969.3402710092137;1992.3325685895243;2016.939491815248;2018.9798102018938;2019.5052212208102;5539.086050801613;5665;6737.528373013891;6781.966090169567;6783.559068660521;3827.2919509890758;3900.2979463696524;3924.7448915820382;3931.2923673738715;3932.410138479251;2626.6979297380853;2662.2811840802874;2691.5155272051024;2694.178275625933;2695.460907818444;870.6125774030559;887.4497811357;892.8392889279927;914.2503147419119;937.7983733497331;8741.431806932593;8845.027047024822;8859.24696400813;8861.911380886173;8866.601002954883;3752.549694036733;3765.3222419964122;3775.679067279312;3808.8286027128847;3818;7722.111957125003;7732.878732583744;7755.573443460664;7766.951461552618;7778.727744529027;4051.6353528182603;4054.493188351456;4059.1475790083823;4097.7746223957965;4124.484439445069;3659.524261845943;3705.277470893204;3707.925841483155;3712.2575484903127;3713.3316003119157;3063.9846800765854;3116.376724655078;3140.057982605255;3142.5757522734593;3143.528470729363;880.2078129683208;880.4717169698258;883.5052370672444;886.4902680958475;892.0811564088999;801.7714951238986;808.934918858975;1135.1316243074054;1141.303804679145;1142.5429828068839;6063.484603808637;6202.937970620326;6210.596311239755;6211.689415529206;6213.5339849511465;406.69701072701025;414.3784323514728;414.4839674605136;417.4031135476237;433.2915682858549;4690.155771961012;4992.375953005874;5017.874553136127;5050.823221187241;5057.949420505822;6966.721331146799;7846;8021.398395120389;8100.392470564731;8119.188081191952;7888.881666775003;7923.445358824827;7949.841003179904;7955.4033447491665;7957.403194760301;6234.688265586702;6296.716647750863;6298.968505157445;6335.841603959846;6352.333005034498;6216.067589861557;6218.284897236876;6219.626822390671;6223.719932602953;6236.937630623635;6995.615241161785;7275.054242948383;7356.080489938758;7377.926220737724;7396.852062958818;7297.963510182415;7380.409567234716;7410.62946852666;7471.589062601609;7505.437092217996;5795.913061304;5800.071988481823;5852.063669812809;5871.6770577618645;5873.500752436091;6625.801225963229;6649.434798042221;6673.1992160941;6683.799486015428;6683.9331606685255;6189.1025801257665;6212.347703491068;6275.623462592259;6303.6532990685955;6341.017142342944;5975.850603734942;6119.265688117454;6214.285357183981;6215.81352559424;6219;6122.5408094392205;6277.874442511215;6287.591306565058;6298;6298.338674439301;5774.0761478163295;5809.070548712186;5828.446297601721;5831.650100993954;5865.354810970704;5872.706364681663;5927.110933360031;5933.317668468181;5940.970295148497;5978.013627751372 17:34:16 INFO - 2015-11-23 17:34:16,932 DEBUG : BROWSER_OUTPUT: |4;prototype.html;302.7986389051281;312.2583863324604;315.5976130433696;316.44306021402326;317.9189306726787;5297.4702529747055;5345.652532585379;5346.010987967229;5417.891642167155;5421.241026256327;5361.678299302035;5383.703896285702;5386.78452861886;5387.946120538793;5392.460753924605;3909.5113110861143;4027;4194.140201258735;4194.286971214886;4197.328427451608;4061.025353915054;4176.958230417703;4183.3515805050265;4195.496540415154;4195.7063005589625;4146.025683964281;4147.191297696951;4150.854720084798;4154.106867023589;4156.085661154541;3890.9221815563674;4026.7583944963394;4027.818748156311;4107.691923105749;4151.750894946313;3644.2164934538937;3646.361886669822;3646.6535679110707;3651.233241019389;3657.3233951719017;5191.8442446726285;5194.896102077937;5204.869878253074;5208.9582083583055;5216.817411390621;4795;4799.640026997954;4800.927986080212;4806.399200099988;4806.774272560475;5527.50252477279;5622.746976386073;5654.46282603152;5668.518175955049;5674.00704876645;4004.8598299059686;4006.559278479365;4008.997750562359;4009.3785463253244;4020.7386519876113;5965.970170149121;5974.044152935509;5976.940230597682;5978.372270911578;5987.64074155552;4135.007598176416;4136.524299705512;4139.81370838313;4140.337545992687;4152.647025002848;4103.302438585448;4190.790460476964;4201.516825565099;4208.789560521962;4231.978840105779;4770.308305295713;4773.856784296477;4776.259679749644;4777.95222047775;4779.832705855279;5649.858753531113;5660.122680984454;5660.518855897212;5665.065264231355;5667.489925906688;1461.7368873602854;1494.9327280272414;1497.4384605772834;1497.4758834408087;1500.167407089076;1022.3967858963099;1023.2734758321526;1026.6560702164709;1036.8600238967642;1059.1526778577108;4970.130227210224;5003.499650034967;5008.273800298936;5011.874703132378;5016.623753218523;5890.646561206341;5898.823035308862;5900.704964751745;5902.4097590240635;5904.586678932434;5000.1749711297225;5003.424606170337;5005.0240203160765;5006.549410553068;5009.549140577293;2946.145617770865;3014;3141.3874294512807;3157.1475701560908;3187.856546455415;5534.723263836792;5619.8595035123635;5626.212330273765;5627.409122042209;5635.8591035224445;6087.3303936566945;6102.176206212104;6102.572819902653;6115.235595550556;6115.694215289218;5613;5623.156526520973;5623.550115990711;5625.071863142535;5630.042892708249;5788.334341550775;5891.23413956183;5926.496247818811;5929.762809487745;5931.288245410578;5765.509931655689;5767.509761670305;5773.451522105393;5782.479576838105;5783.19035335045;5592.664440133605;5595.692236927008;5597.6641401516035;5599.04816181242;5605.32736071674;4077.368007958771;4165.354370072643;4169.312063509608;4170.72890262132;4189.16216756656;5890.793822216202;5892.469677729025;5907.527397808251;5913.615614985012;5920.319163296103;5694.487496125369;5703.971480142573;5707.315122185364;5708.828735137952;5712.742926568398;5590.217369568182;5692.686902220417;5698.487136157766;5700.315962084576;5718.085106382959;5531.861703457445;5552.750126244248;5552.972235138798;5555.000099982042;5558.305211848519;5732.369439361751;5733.369329373849;5741.224934633771;5744.540436765133;5746.683932383759;5326.467353264798;5421.05131601976;5522.696251706034;5527.944720552743;5533.363663178625 17:34:16 INFO - 2015-11-23 17:34:16,932 DEBUG : BROWSER_OUTPUT: |5;yui.html;656.4223483334665;669.4109183918151;700.2437367642946;726.5749536521134;761.2615762710169;11101.111911047117;11361.772764544714;11379.260348077369;11390;11404.429778511083;12813.167144135625;13018.60944171674;13033.218006919567;13103.868961310383;13106.279154646514;546.8523498655361;553.0266730554233;759.5101159751956;773.5242825662206;775.5540564175593;554.1134185303522;757.6249756370604;773.3967505345811;774.1097737601747;774.7365895595497;796.8406318736247;805.1264378149715;810.8256724804166;811.0186674124317;811.2739098506833;549.0446622876207;556.0907915558051;794.51931581393;802.8880001198324;806.7660378490231;601.7893737191991;601.8946684330268;602.6474512410246;602.677567501389;602.7769725201659;11899.345535995517;11977.520899164023;11985.580504682293;11986.220895641756;11993.94003029988;10252.846207306897;10746.570137194503;11134.721631959184;11330;11409.144314176387;8521;8704.303655707528;8723.563821808948;8754.69358572447;9467.195288400495;3014.623172103487;3016.743576795975;3037.9822759375634;3043.433047939259;3084.3985422842557;39588.60411395878;40616.187676246605;40701.59298407008;40764;40926.38610420816;8906.821863562693;9186.908130918739;9232.676856309998;9266;9279.860802087975;13636;13637;13658.385372658255;13665.931670341584;13680.31598420075;6059.424354686298;6218.968905155445;6312.779052733133;6357.4914006879335;6501.707423165969;3500.964990350064;3521.3837578423672;3563.893083207456;3574.1779390740276;3625.220577575834;2641.8546979915905;2700.486907487571;2701.392186757964;2707.837529748221;2715.212588349396;464.59580165256443;465.5646970082983;476.24752890433035;476.4592187866727;484.1285685765608;451.6499712722666;452.93658887755083;480.03033871579913;546.0989367543585;553.4327314502667;7213.49505534618;7281.344678978918;7453.329200371993;7471.7758467244985;7476.775696729107;424.6920982287817;432.6949500602068;495.74716894384125;538.8087229033715;548.8216329692866;3405.1146701857697;3504.649535046526;3635.9636403636155;3783.6027217141805;3796.620337966181;51458.48541514537;51896.74051629718;51898;51991;51998.22002669963;43761.78119109384;44839.327410088874;44847.10305793866;44897.55102448934;45345;40725.59274407218;41051;41374.58625413768;41396.172076558905;41865.79067104645;6667.666616669244;6724.260331363448;6828.453723701992;6862.416694581017;6957.8956315654295;30683;31132.844335778176;31694.683053169174;31704.207394815316;32027.83986080148;37109.81445092757;37322.813385932895;39819;41331.7933410331;41773.791131045364;8401;8568.742937711879;8672.349573781865;8871.556422178735;9034.322425817958;9019.864702029607;9264.907350926675;9321.067893210897;9455.905440945502;9722.708318750449;9489.193418559224;9504.19214366759;9661.46861922601;9694.46680432583;10065.547050382604;8945.329100317373;9022.368434209542;9128.317639642475;9173.036831132635;9180;8815.955920220358;8821.867671985054;8940.73177804667;9125.31560133006;9129.680461183827;7614.8096297593;7847.254510821463;7868.72459463916;7930.920690793018;7951.642176102205;7053.682584283617;7609.2010338913615;7778.92221077782;7915.0897646771355;7961.16407777175 17:34:16 INFO - 2015-11-23 17:34:16,932 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:34:16 INFO - 2015-11-23 17:34:16,932 DEBUG : BROWSER_OUTPUT: __start_cc_report 17:34:16 INFO - 2015-11-23 17:34:16,932 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,851 17:34:16 INFO - 2015-11-23 17:34:16,932 DEBUG : BROWSER_OUTPUT: __end_cc_report 17:34:16 INFO - 2015-11-23 17:34:16,932 DEBUG : BROWSER_OUTPUT: __startTimestamp1448328856922__endTimestamp 17:34:16 INFO - 2015-11-23 17:34:16,932 DEBUG : BROWSER_OUTPUT: 17:34:16 INFO - 2015-11-23 17:34:16,933 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:34:16 INFO - 2015-11-23 17:34:16,933 DEBUG : BROWSER_OUTPUT: Number of tests: 6 17:34:16 INFO - 2015-11-23 17:34:16,933 DEBUG : BROWSER_OUTPUT: 17:34:16 INFO - 2015-11-23 17:34:16,933 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4616.55 Median:4771.00 stddev:480.92 (10.1%) stddev-sans-first:456.07 17:34:16 INFO - 2015-11-23 17:34:16,934 DEBUG : BROWSER_OUTPUT: Values: 2616.3 2677.5 2680.6 2695.0 2717.6 4519.6 4635.5 4648.9 4656.3 4666.2 4582.5 4626.7 4673.5 4690.9 4817.2 4285.3 4299.0 4303.4 4326.5 4338.0 4090.6 4338.4 4353.6 4399.5 4409.3 4192.2 4216.9 4250.6 4350.6 4392.1 4337.1 4337.2 4345.0 4358.6 4380.1 4298.5 4313.1 4318.1 4348.8 4357.4 4413.4 4479.6 4494.8 4531.4 4539.5 5021.7 5054.3 5055.2 5055.9 5059.3 5015.1 5082.4 5099.4 5128.8 5129.1 4556.0 4674.5 4684.9 4686.4 4723.5 4994.1 5027.2 5037.3 5046.1 5072.7 4856.6 4858.2 4868.9 4869.0 4907.8 4819.6 4914.6 4921.2 4971.3 5024.2 4939.5 5013.5 5036.4 5038.3 5099.4 4927.6 4931.9 4932.0 4932.5 4978.8 4011.1 4058.1 4100.7 4185.0 4204.1 3594.9 3623.3 3667.9 3669.3 3694.4 4371.5 4396.9 4397.8 4408.2 4432.9 4838.2 4936.7 5079.4 5091.3 5136.8 4268.9 4281.8 4353.3 4364.3 4371.0 4430.7 4431.7 4439.6 4446.0 4476.1 4766.5 4770.5 4771.0 4771.9 4809.9 4830.3 4887.1 4949.5 4953.1 5000.3 4785.1 4808.8 4816.8 4823.4 4858.7 4990.9 4991.6 4993.6 4996.3 5026.6 4792.9 4885.7 4907.9 4914.1 4987.0 4884.6 4915.9 4927.8 4930.0 4957.9 4899.1 4915.0 4920.4 4921.7 4960.2 4544.3 4646.3 4733.8 4744.7 4745.6 4739.2 4964.9 4966.9 4969.2 4971.0 4854.2 4854.3 4854.5 4854.6 4856.2 17:34:16 INFO - 2015-11-23 17:34:16,934 DEBUG : BROWSER_OUTPUT: 17:34:16 INFO - 2015-11-23 17:34:16,934 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42930.76 Median:174887.10 stddev:72769.72 (41.6%) stddev-sans-first:72904.27 17:34:16 INFO - 2015-11-23 17:34:16,934 DEBUG : BROWSER_OUTPUT: Values: 543.3 553.9 556.0 562.3 575.6 25207.5 25924.9 36747.4 37532.4 37538.6 39558.8 40187.2 40238.6 40263.2 40286.2 6809.6 7012.7 7911.8 8023.1 8089.2 10152.5 10407.4 10421.0 10436.6 10439.7 10022.1 10115.8 10125.6 10130.2 10136.8 6851.2 7036.6 10025.5 10031.0 10251.8 9751.4 9886.8 9913.6 9926.1 9940.3 36908.1 37413.0 37477.3 37499.4 37574.4 2749.3 2758.2 2782.7 2797.2 2823.5 27689.7 27794.4 27847.3 28100.6 28561.9 3379.8 3523.5 3564.1 3568.8 3717.4 223689.0 226305.0 226651.0 226863.0 227277.0 40303.4 40759.0 54819.7 55818.4 56879.0 51431.0 51468.5 51728.7 51855.5 51857.5 13621.8 13816.4 13818.4 13830.2 13831.7 10539.1 10606.7 10612.7 10619.2 10735.2 18662.9 18733.8 18779.6 18800.3 18815.0 7504.4 7711.2 7744.4 7929.8 7948.7 870.4 884.5 916.1 946.7 949.2 25942.5 26132.6 26257.3 26371.9 26516.3 936.9 957.5 960.3 968.3 1029.1 13856.2 13862.2 13891.7 14029.7 14990.2 317968.0 323296.0 323926.0 326014.0 326184.0 48719.0 48929.0 49089.3 49136.8 49213.8 1197.6 1217.6 1227.7 1229.5 1241.1 26495.0 27306.7 27401.6 27949.3 27961.2 39226.0 39690.0 39715.2 39718.0 39749.0 240244.0 242450.0 290168.0 295965.0 305813.0 28536.9 28732.7 28757.0 29015.4 29220.7 36874.0 37772.6 37964.9 38359.8 38361.6 22228.4 32040.2 32543.5 32621.7 33066.7 24510.3 29199.0 29232.4 29350.4 37170.6 33713.5 34131.3 34324.1 34491.0 34847.0 30138.7 31114.0 31335.7 31755.0 31806.2 24520.4 24542.0 24658.3 24835.4 25032.9 17:34:16 INFO - 2015-11-23 17:34:16,934 DEBUG : BROWSER_OUTPUT: 17:34:16 INFO - 2015-11-23 17:34:16,934 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25903.78 Median:42944.18 stddev:83824.06 (195.2%) stddev-sans-first:84037.21 17:34:16 INFO - 2015-11-23 17:34:16,935 DEBUG : BROWSER_OUTPUT: Values: 330.9 332.6 337.0 337.1 337.2 14955.0 15334.4 15428.3 16078.4 16081.8 9983.8 13380.0 13616.9 13635.2 13669.9 4379.5 4507.3 4512.9 4515.4 4515.6 4490.8 4525.6 4530.6 4536.8 4548.5 2982.1 3070.1 4525.7 4691.2 4895.7 4987.0 4993.0 5005.7 5023.9 5036.4 4755.5 4808.3 4826.2 4831.4 4916.5 9394.3 9622.7 9723.3 10007.4 10053.3 1775.9 1779.9 1824.5 1836.4 1844.1 8484.8 8570.5 8661.0 8923.2 8998.9 1706.9 1736.6 1770.1 1771.5 1772.8 51471.2 52424.5 53827.7 54256.2 54634.0 9276.3 9411.6 9424.7 9449.7 9512.9 11881.2 11912.0 11941.6 11954.5 11970.6 6943.8 6992.4 7001.7 7014.3 7125.9 6668.8 6682.5 6696.5 6726.1 6727.7 3964.8 4030.3 4031.4 4038.5 4076.7 1630.7 1647.6 1669.1 1679.8 1695.8 642.4 817.4 879.8 880.3 887.5 13026.4 14900.9 15807.3 16244.3 16339.9 801.7 821.2 860.7 910.5 933.5 8327.3 8386.7 8688.6 8693.4 8830.2 508451.0 510014.0 516812.0 517260.0 518347.0 39699.0 50214.0 51626.5 65968.7 68782.7 1074.3 1075.1 1114.6 1134.0 1137.9 14056.2 14530.8 14568.6 14685.2 14859.6 30365.2 31119.7 31990.8 32704.2 32759.3 40106.6 42036.4 42273.4 42672.8 43215.6 8219.2 8707.1 8912.0 8934.6 8942.0 9943.7 9958.1 10001.8 10017.1 10089.0 11817.8 13564.9 13772.7 13884.4 14266.9 12822.4 12964.6 13637.3 13825.2 13969.3 13402.2 13443.5 13551.8 13611.8 13977.0 8409.8 8451.7 8681.4 8701.2 8711.8 12090.2 12240.1 12465.1 12617.2 12838.6 17:34:16 INFO - 2015-11-23 17:34:16,935 DEBUG : BROWSER_OUTPUT: 17:34:16 INFO - 2015-11-23 17:34:16,935 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4692.03 Median:5976.93 stddev:2422.84 (40.5%) stddev-sans-first:2414.48 17:34:16 INFO - 2015-11-23 17:34:16,936 DEBUG : BROWSER_OUTPUT: Values: 1087.5 1356.7 1417.5 1489.2 1673.6 5813.1 6451.3 6629.1 6637.2 6661.5 6550.2 6573.6 6653.0 6676.8 6691.9 1945.5 2004.8 2006.3 2006.6 2008.5 2014.3 2015.4 2027.7 2045.2 2054.3 1971.5 1986.9 2002.9 2004.4 2005.5 2020.3 2028.4 2031.1 2032.7 2034.4 1969.3 1992.3 2016.9 2019.0 2019.5 5539.1 5665.0 6737.5 6782.0 6783.6 3827.3 3900.3 3924.7 3931.3 3932.4 2626.7 2662.3 2691.5 2694.2 2695.5 870.6 887.4 892.8 914.3 937.8 8741.4 8845.0 8859.2 8861.9 8866.6 3752.5 3765.3 3775.7 3808.8 3818.0 7722.1 7732.9 7755.6 7767.0 7778.7 4051.6 4054.5 4059.1 4097.8 4124.5 3659.5 3705.3 3707.9 3712.3 3713.3 3064.0 3116.4 3140.1 3142.6 3143.5 880.2 880.5 883.5 886.5 892.1 801.8 808.9 1135.1 1141.3 1142.5 6063.5 6202.9 6210.6 6211.7 6213.5 406.7 414.4 414.5 417.4 433.3 4690.2 4992.4 5017.9 5050.8 5057.9 6966.7 7846.0 8021.4 8100.4 8119.2 7888.9 7923.4 7949.8 7955.4 7957.4 6234.7 6296.7 6299.0 6335.8 6352.3 6216.1 6218.3 6219.6 6223.7 6236.9 6995.6 7275.1 7356.1 7377.9 7396.9 7298.0 7380.4 7410.6 7471.6 7505.4 5795.9 5800.1 5852.1 5871.7 5873.5 6625.8 6649.4 6673.2 6683.8 6683.9 6189.1 6212.3 6275.6 6303.7 6341.0 5975.9 6119.3 6214.3 6215.8 6219.0 6122.5 6277.9 6287.6 6298.0 6298.3 5774.1 5809.1 5828.4 5831.7 5865.4 5872.7 5927.1 5933.3 5941.0 5978.0 17:34:16 INFO - 2015-11-23 17:34:16,936 DEBUG : BROWSER_OUTPUT: 17:34:16 INFO - 2015-11-23 17:34:16,936 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4718.83 Median:5311.97 stddev:1383.54 (26.0%) stddev-sans-first:1347.14 17:34:16 INFO - 2015-11-23 17:34:16,936 DEBUG : BROWSER_OUTPUT: Values: 302.8 312.3 315.6 316.4 317.9 5297.5 5345.7 5346.0 5417.9 5421.2 5361.7 5383.7 5386.8 5387.9 5392.5 3909.5 4027.0 4194.1 4194.3 4197.3 4061.0 4177.0 4183.4 4195.5 4195.7 4146.0 4147.2 4150.9 4154.1 4156.1 3890.9 4026.8 4027.8 4107.7 4151.8 3644.2 3646.4 3646.7 3651.2 3657.3 5191.8 5194.9 5204.9 5209.0 5216.8 4795.0 4799.6 4800.9 4806.4 4806.8 5527.5 5622.7 5654.5 5668.5 5674.0 4004.9 4006.6 4009.0 4009.4 4020.7 5966.0 5974.0 5976.9 5978.4 5987.6 4135.0 4136.5 4139.8 4140.3 4152.6 4103.3 4190.8 4201.5 4208.8 4232.0 4770.3 4773.9 4776.3 4778.0 4779.8 5649.9 5660.1 5660.5 5665.1 5667.5 1461.7 1494.9 1497.4 1497.5 1500.2 1022.4 1023.3 1026.7 1036.9 1059.2 4970.1 5003.5 5008.3 5011.9 5016.6 5890.6 5898.8 5900.7 5902.4 5904.6 5000.2 5003.4 5005.0 5006.5 5009.5 2946.1 3014.0 3141.4 3157.1 3187.9 5534.7 5619.9 5626.2 5627.4 5635.9 6087.3 6102.2 6102.6 6115.2 6115.7 5613.0 5623.2 5623.6 5625.1 5630.0 5788.3 5891.2 5926.5 5929.8 5931.3 5765.5 5767.5 5773.5 5782.5 5783.2 5592.7 5595.7 5597.7 5599.0 5605.3 4077.4 4165.4 4169.3 4170.7 4189.2 5890.8 5892.5 5907.5 5913.6 5920.3 5694.5 5704.0 5707.3 5708.8 5712.7 5590.2 5692.7 5698.5 5700.3 5718.1 5531.9 5552.8 5553.0 5555.0 5558.3 5732.4 5733.4 5741.2 5744.5 5746.7 5326.5 5421.1 5522.7 5527.9 5533.4 17:34:16 INFO - 2015-11-23 17:34:16,936 DEBUG : BROWSER_OUTPUT: 17:34:16 INFO - 2015-11-23 17:34:16,936 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11906.78 Median:548.93 stddev:14103.98 (2569.3%) stddev-sans-first:14118.24 17:34:16 INFO - 2015-11-23 17:34:16,936 DEBUG : BROWSER_OUTPUT: Values: 656.4 669.4 700.2 726.6 761.3 11101.1 11361.8 11379.3 11390.0 11404.4 12813.2 13018.6 13033.2 13103.9 13106.3 546.9 553.0 759.5 773.5 775.6 554.1 757.6 773.4 774.1 774.7 796.8 805.1 810.8 811.0 811.3 549.0 556.1 794.5 802.9 806.8 601.8 601.9 602.6 602.7 602.8 11899.3 11977.5 11985.6 11986.2 11993.9 10252.8 10746.6 11134.7 11330.0 11409.1 8521.0 8704.3 8723.6 8754.7 9467.2 3014.6 3016.7 3038.0 3043.4 3084.4 39588.6 40616.2 40701.6 40764.0 40926.4 8906.8 9186.9 9232.7 9266.0 9279.9 13636.0 13637.0 13658.4 13665.9 13680.3 6059.4 6219.0 6312.8 6357.5 6501.7 3501.0 3521.4 3563.9 3574.2 3625.2 2641.9 2700.5 2701.4 2707.8 2715.2 464.6 465.6 476.2 476.5 484.1 451.6 452.9 480.0 546.1 553.4 7213.5 7281.3 7453.3 7471.8 7476.8 424.7 432.7 495.7 538.8 548.8 3405.1 3504.6 3636.0 3783.6 3796.6 51458.5 51896.7 51898.0 51991.0 51998.2 43761.8 44839.3 44847.1 44897.6 45345.0 40725.6 41051.0 41374.6 41396.2 41865.8 6667.7 6724.3 6828.5 6862.4 6957.9 30683.0 31132.8 31694.7 31704.2 32027.8 37109.8 37322.8 39819.0 41331.8 41773.8 8401.0 8568.7 8672.3 8871.6 9034.3 9019.9 9264.9 9321.1 9455.9 9722.7 9489.2 9504.2 9661.5 9694.5 10065.5 8945.3 9022.4 9128.3 9173.0 9180.0 8816.0 8821.9 8940.7 9125.3 9129.7 7614.8 7847.3 7868.7 7930.9 7951.6 7053.7 7609.2 7778.9 7915.1 7961.2 17:34:16 INFO - 2015-11-23 17:34:16,936 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:34:16 INFO - 2015-11-23 17:34:16,937 DEBUG : BROWSER_OUTPUT: 17:34:17 INFO - 2015-11-23 17:34:17,693 INFO : Browser exited with error code: 0 17:34:17 INFO - 2015-11-23 17:34:17,714 INFO : Completed test dromaeo_css (00:18:38) 17:34:17 INFO - 2015-11-23 17:34:17,714 INFO : Starting test kraken 17:34:17 INFO - 2015-11-23 17:34:17,714 DEBUG : operating with platform_type : linux_ 17:34:17 INFO - 2015-11-23 17:34:17,715 INFO : Initialising browser for kraken test... 17:34:17 INFO - 2015-11-23 17:34:17,721 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmERDqL/profile http://localhost:46747/getInfo.html 17:34:21 INFO - 2015-11-23 17:34:21,831 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:34:21 INFO - 2015-11-23 17:34:21,831 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:34:21 INFO - 2015-11-23 17:34:21,831 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 17:34:21 INFO - 2015-11-23 17:34:21,831 DEBUG : BROWSER_OUTPUT: __metrics 17:34:22 INFO - 2015-11-23 17:34:22,013 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:34:23 INFO - 2015-11-23 17:34:23,391 INFO : Browser initialized. 17:34:23 INFO - 2015-11-23 17:34:23,391 INFO : Running cycle 1/1 for kraken test... 17:34:23 INFO - 2015-11-23 17:34:23,392 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmERDqL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:34:35 INFO - 2015-11-23 17:34:35,391 DEBUG : BROWSER_OUTPUT: RSS: Main: 140214272 17:34:35 INFO - 2015-11-23 17:34:35,391 DEBUG : BROWSER_OUTPUT: 17:34:38 INFO - 2015-11-23 17:34:38,050 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46747/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46747/tests/kraken/driver.html?testName=audio-beat-detection) 17:34:38 INFO - 2015-11-23 17:34:38,639 DEBUG : BROWSER_OUTPUT: RSS: Main: 177369088 17:34:38 INFO - 2015-11-23 17:34:38,639 DEBUG : BROWSER_OUTPUT: 17:34:41 INFO - 2015-11-23 17:34:41,361 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46747/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46747/tests/kraken/driver.html?testName=audio-dft) 17:34:41 INFO - 2015-11-23 17:34:41,930 DEBUG : BROWSER_OUTPUT: RSS: Main: 169291776 17:34:41 INFO - 2015-11-23 17:34:41,930 DEBUG : BROWSER_OUTPUT: 17:34:44 INFO - 2015-11-23 17:34:44,963 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46747/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46747/tests/kraken/driver.html?testName=audio-fft) 17:34:45 INFO - 2015-11-23 17:34:45,530 DEBUG : BROWSER_OUTPUT: RSS: Main: 151683072 17:34:45 INFO - 2015-11-23 17:34:45,530 DEBUG : BROWSER_OUTPUT: 17:34:47 INFO - 2015-11-23 17:34:47,571 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46747/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46747/tests/kraken/driver.html?testName=audio-oscillator) 17:34:48 INFO - 2015-11-23 17:34:48,144 DEBUG : BROWSER_OUTPUT: RSS: Main: 155394048 17:34:48 INFO - 2015-11-23 17:34:48,144 DEBUG : BROWSER_OUTPUT: 17:34:50 INFO - 2015-11-23 17:34:50,398 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46747/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46747/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:34:50 INFO - 2015-11-23 17:34:50,980 DEBUG : BROWSER_OUTPUT: RSS: Main: 154845184 17:34:50 INFO - 2015-11-23 17:34:50,980 DEBUG : BROWSER_OUTPUT: 17:34:53 INFO - 2015-11-23 17:34:53,985 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46747/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46747/tests/kraken/driver.html?testName=imaging-darkroom) 17:34:54 INFO - 2015-11-23 17:34:54,566 DEBUG : BROWSER_OUTPUT: RSS: Main: 156422144 17:34:54 INFO - 2015-11-23 17:34:54,567 DEBUG : BROWSER_OUTPUT: 17:34:57 INFO - 2015-11-23 17:34:57,995 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46747/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46747/tests/kraken/driver.html?testName=imaging-desaturate) 17:34:58 INFO - 2015-11-23 17:34:58,564 DEBUG : BROWSER_OUTPUT: RSS: Main: 157655040 17:34:58 INFO - 2015-11-23 17:34:58,564 DEBUG : BROWSER_OUTPUT: 17:35:01 INFO - 2015-11-23 17:35:01,475 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46747/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46747/tests/kraken/driver.html?testName=json-parse-financial) 17:35:02 INFO - 2015-11-23 17:35:02,057 DEBUG : BROWSER_OUTPUT: RSS: Main: 158248960 17:35:02 INFO - 2015-11-23 17:35:02,057 DEBUG : BROWSER_OUTPUT: 17:35:03 INFO - 2015-11-23 17:35:03,827 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46747/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46747/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:35:04 INFO - 2015-11-23 17:35:04,394 DEBUG : BROWSER_OUTPUT: RSS: Main: 166309888 17:35:04 INFO - 2015-11-23 17:35:04,395 DEBUG : BROWSER_OUTPUT: 17:35:06 INFO - 2015-11-23 17:35:06,288 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46747/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46747/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:35:06 INFO - 2015-11-23 17:35:06,875 DEBUG : BROWSER_OUTPUT: RSS: Main: 164184064 17:35:06 INFO - 2015-11-23 17:35:06,875 DEBUG : BROWSER_OUTPUT: 17:35:09 INFO - 2015-11-23 17:35:09,033 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46747/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46747/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:35:09 INFO - 2015-11-23 17:35:09,619 DEBUG : BROWSER_OUTPUT: RSS: Main: 175349760 17:35:09 INFO - 2015-11-23 17:35:09,620 DEBUG : BROWSER_OUTPUT: 17:35:12 INFO - 2015-11-23 17:35:12,140 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46747/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46747/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:35:12 INFO - 2015-11-23 17:35:12,721 DEBUG : BROWSER_OUTPUT: RSS: Main: 183742464 17:35:12 INFO - 2015-11-23 17:35:12,721 DEBUG : BROWSER_OUTPUT: 17:35:15 INFO - 2015-11-23 17:35:15,329 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46747/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46747/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:35:15 INFO - 2015-11-23 17:35:15,910 DEBUG : BROWSER_OUTPUT: RSS: Main: 180531200 17:35:15 INFO - 2015-11-23 17:35:15,910 DEBUG : BROWSER_OUTPUT: 17:35:17 INFO - 2015-11-23 17:35:17,665 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46747/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46747/tests/kraken/driver.html?testName=ai-astar) 17:35:17 INFO - 2015-11-23 17:35:17,915 DEBUG : BROWSER_OUTPUT: RSS: Main: 240508928 17:35:17 INFO - 2015-11-23 17:35:17,916 DEBUG : BROWSER_OUTPUT: 17:35:17 INFO - 2015-11-23 17:35:17,917 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:35:17 INFO - 2015-11-23 17:35:17,917 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:35:17 INFO - 2015-11-23 17:35:17,917 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:35:17 INFO - 2015-11-23 17:35:17,917 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:35:17 INFO - 2015-11-23 17:35:17,918 DEBUG : BROWSER_OUTPUT: |0;ai-astar;114;116;107;115;115;115;104;115;114;103 17:35:17 INFO - 2015-11-23 17:35:17,918 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;159;137;161;167;136;157;152;131;172;131 17:35:17 INFO - 2015-11-23 17:35:17,918 DEBUG : BROWSER_OUTPUT: |2;audio-dft;165;162;163;163;163;162;165;163;161;162 17:35:17 INFO - 2015-11-23 17:35:17,918 DEBUG : BROWSER_OUTPUT: |3;audio-fft;74;74;85;104;74;72;76;108;87;71 17:35:17 INFO - 2015-11-23 17:35:17,918 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;94;144;94;94;95;136;96;95;131 17:35:17 INFO - 2015-11-23 17:35:17,918 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;110;109;110;110;110;110;109;109 17:35:17 INFO - 2015-11-23 17:35:17,918 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;148;148;146;147;147;147;148;148;148 17:35:17 INFO - 2015-11-23 17:35:17,918 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;96;95;96;95;95;96;95;95 17:35:17 INFO - 2015-11-23 17:35:17,919 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;72;71;73;71;72;72;72;82;71;71 17:35:17 INFO - 2015-11-23 17:35:17,919 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;70;70;70;71;71;70;70;71;71;70 17:35:17 INFO - 2015-11-23 17:35:17,919 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;90;84;84;82;84;85;85;85;83 17:35:17 INFO - 2015-11-23 17:35:17,919 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;122;127;122;119;131;142;123;123;122;122 17:35:17 INFO - 2015-11-23 17:35:17,919 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;151;146;149;160;152;143;156;154;143;139 17:35:17 INFO - 2015-11-23 17:35:17,919 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;70;69;68;69;69;69;69;69;69 17:35:17 INFO - 2015-11-23 17:35:17,919 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:35:17 INFO - 2015-11-23 17:35:17,919 DEBUG : BROWSER_OUTPUT: __start_cc_report 17:35:17 INFO - 2015-11-23 17:35:17,920 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,988 17:35:17 INFO - 2015-11-23 17:35:17,920 DEBUG : BROWSER_OUTPUT: __end_cc_report 17:35:17 INFO - 2015-11-23 17:35:17,920 DEBUG : BROWSER_OUTPUT: __startTimestamp1448328917916__endTimestamp 17:35:17 INFO - 2015-11-23 17:35:17,920 DEBUG : BROWSER_OUTPUT: 17:35:17 INFO - 2015-11-23 17:35:17,923 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:35:17 INFO - 2015-11-23 17:35:17,924 DEBUG : BROWSER_OUTPUT: Number of tests: 14 17:35:17 INFO - 2015-11-23 17:35:17,924 DEBUG : BROWSER_OUTPUT: 17:35:17 INFO - 2015-11-23 17:35:17,924 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.80 Median:115.00 stddev:5.05 (4.4%) stddev-sans-first:5.29 17:35:17 INFO - 2015-11-23 17:35:17,925 DEBUG : BROWSER_OUTPUT: Values: 114.0 116.0 107.0 115.0 115.0 115.0 104.0 115.0 114.0 103.0 17:35:17 INFO - 2015-11-23 17:35:17,925 DEBUG : BROWSER_OUTPUT: 17:35:17 INFO - 2015-11-23 17:35:17,925 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.30 Median:158.00 stddev:15.33 (9.7%) stddev-sans-first:15.93 17:35:17 INFO - 2015-11-23 17:35:17,925 DEBUG : BROWSER_OUTPUT: Values: 159.0 137.0 161.0 167.0 136.0 157.0 152.0 131.0 172.0 131.0 17:35:17 INFO - 2015-11-23 17:35:17,925 DEBUG : BROWSER_OUTPUT: 17:35:17 INFO - 2015-11-23 17:35:17,926 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.90 Median:163.00 stddev:1.29 (0.8%) stddev-sans-first:1.12 17:35:17 INFO - 2015-11-23 17:35:17,926 DEBUG : BROWSER_OUTPUT: Values: 165.0 162.0 163.0 163.0 163.0 162.0 165.0 163.0 161.0 162.0 17:35:17 INFO - 2015-11-23 17:35:17,926 DEBUG : BROWSER_OUTPUT: 17:35:17 INFO - 2015-11-23 17:35:17,926 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:82.50 Median:74.00 stddev:13.50 (18.2%) stddev-sans-first:13.97 17:35:17 INFO - 2015-11-23 17:35:17,926 DEBUG : BROWSER_OUTPUT: Values: 74.0 74.0 85.0 104.0 74.0 72.0 76.0 108.0 87.0 71.0 17:35:17 INFO - 2015-11-23 17:35:17,926 DEBUG : BROWSER_OUTPUT: 17:35:17 INFO - 2015-11-23 17:35:17,926 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.40 Median:94.50 stddev:20.67 (21.9%) stddev-sans-first:21.43 17:35:17 INFO - 2015-11-23 17:35:17,926 DEBUG : BROWSER_OUTPUT: Values: 95.0 94.0 144.0 94.0 94.0 95.0 136.0 96.0 95.0 131.0 17:35:17 INFO - 2015-11-23 17:35:17,926 DEBUG : BROWSER_OUTPUT: 17:35:17 INFO - 2015-11-23 17:35:17,926 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 17:35:17 INFO - 2015-11-23 17:35:17,926 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 110.0 109.0 110.0 110.0 110.0 110.0 109.0 109.0 17:35:17 INFO - 2015-11-23 17:35:17,926 DEBUG : BROWSER_OUTPUT: 17:35:17 INFO - 2015-11-23 17:35:17,926 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.40 Median:148.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 17:35:17 INFO - 2015-11-23 17:35:17,926 DEBUG : BROWSER_OUTPUT: Values: 147.0 148.0 148.0 146.0 147.0 147.0 147.0 148.0 148.0 148.0 17:35:17 INFO - 2015-11-23 17:35:17,926 DEBUG : BROWSER_OUTPUT: 17:35:17 INFO - 2015-11-23 17:35:17,926 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 17:35:17 INFO - 2015-11-23 17:35:17,927 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 96.0 95.0 96.0 95.0 95.0 96.0 95.0 95.0 17:35:17 INFO - 2015-11-23 17:35:17,927 DEBUG : BROWSER_OUTPUT: 17:35:17 INFO - 2015-11-23 17:35:17,927 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.70 Median:72.00 stddev:3.33 (4.6%) stddev-sans-first:3.53 17:35:17 INFO - 2015-11-23 17:35:17,927 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 73.0 71.0 72.0 72.0 72.0 82.0 71.0 71.0 17:35:17 INFO - 2015-11-23 17:35:17,927 DEBUG : BROWSER_OUTPUT: 17:35:17 INFO - 2015-11-23 17:35:17,927 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:70.40 Median:70.50 stddev:0.52 (0.7%) stddev-sans-first:0.53 17:35:17 INFO - 2015-11-23 17:35:17,927 DEBUG : BROWSER_OUTPUT: Values: 70.0 70.0 70.0 71.0 71.0 70.0 70.0 71.0 71.0 70.0 17:35:17 INFO - 2015-11-23 17:35:17,927 DEBUG : BROWSER_OUTPUT: 17:35:17 INFO - 2015-11-23 17:35:17,927 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:84.50 stddev:2.27 (2.7%) stddev-sans-first:2.24 17:35:17 INFO - 2015-11-23 17:35:17,927 DEBUG : BROWSER_OUTPUT: Values: 82.0 90.0 84.0 84.0 82.0 84.0 85.0 85.0 85.0 83.0 17:35:17 INFO - 2015-11-23 17:35:17,927 DEBUG : BROWSER_OUTPUT: 17:35:17 INFO - 2015-11-23 17:35:17,927 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.30 Median:123.00 stddev:6.73 (5.5%) stddev-sans-first:7.04 17:35:17 INFO - 2015-11-23 17:35:17,927 DEBUG : BROWSER_OUTPUT: Values: 122.0 127.0 122.0 119.0 131.0 142.0 123.0 123.0 122.0 122.0 17:35:17 INFO - 2015-11-23 17:35:17,927 DEBUG : BROWSER_OUTPUT: 17:35:17 INFO - 2015-11-23 17:35:17,927 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.30 Median:151.50 stddev:6.57 (4.3%) stddev-sans-first:6.94 17:35:17 INFO - 2015-11-23 17:35:17,927 DEBUG : BROWSER_OUTPUT: Values: 151.0 146.0 149.0 160.0 152.0 143.0 156.0 154.0 143.0 139.0 17:35:17 INFO - 2015-11-23 17:35:17,927 DEBUG : BROWSER_OUTPUT: 17:35:17 INFO - 2015-11-23 17:35:17,928 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.00 stddev:0.47 (0.7%) stddev-sans-first:0.50 17:35:17 INFO - 2015-11-23 17:35:17,928 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 69.0 68.0 69.0 69.0 69.0 69.0 69.0 69.0 17:35:17 INFO - 2015-11-23 17:35:17,928 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:35:17 INFO - 2015-11-23 17:35:17,928 DEBUG : BROWSER_OUTPUT: 17:35:18 INFO - 2015-11-23 17:35:18,925 INFO : Browser exited with error code: 0 17:35:18 INFO - 2015-11-23 17:35:18,977 INFO : Completed test kraken (00:01:01) 17:35:18 INFO - 2015-11-23 17:35:18,977 INFO : Starting test v8_7 17:35:18 INFO - 2015-11-23 17:35:18,977 DEBUG : operating with platform_type : linux_ 17:35:18 INFO - 2015-11-23 17:35:18,977 INFO : Initialising browser for v8_7 test... 17:35:18 INFO - 2015-11-23 17:35:18,983 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAgmFIr/profile http://localhost:46747/getInfo.html 17:35:23 INFO - 2015-11-23 17:35:23,455 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:35:23 INFO - 2015-11-23 17:35:23,456 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:35:23 INFO - 2015-11-23 17:35:23,456 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 17:35:23 INFO - 2015-11-23 17:35:23,456 DEBUG : BROWSER_OUTPUT: __metrics 17:35:23 INFO - 2015-11-23 17:35:23,617 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:35:25 INFO - 2015-11-23 17:35:25,052 INFO : Browser initialized. 17:35:25 INFO - 2015-11-23 17:35:25,053 INFO : Running cycle 1/1 for v8_7 test... 17:35:25 INFO - 2015-11-23 17:35:25,053 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAgmFIr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:35:36 INFO - 2015-11-23 17:35:36,938 DEBUG : BROWSER_OUTPUT: RSS: Main: 139984896 17:35:36 INFO - 2015-11-23 17:35:36,938 DEBUG : BROWSER_OUTPUT: 17:35:58 INFO - 2015-11-23 17:35:58,424 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46747/tests/v8_7/run.html (next: http://localhost:46747/tests/v8_7/run.html) 17:35:58 INFO - 2015-11-23 17:35:58,673 DEBUG : BROWSER_OUTPUT: RSS: Main: 449241088 17:35:58 INFO - 2015-11-23 17:35:58,674 DEBUG : BROWSER_OUTPUT: 17:35:58 INFO - 2015-11-23 17:35:58,674 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:35:58 INFO - 2015-11-23 17:35:58,674 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:35:58 INFO - 2015-11-23 17:35:58,674 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:35:58 INFO - 2015-11-23 17:35:58,674 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:35:58 INFO - 2015-11-23 17:35:58,674 DEBUG : BROWSER_OUTPUT: |0;Richards;191.0949742021785 17:35:58 INFO - 2015-11-23 17:35:58,674 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.28912071535024 17:35:58 INFO - 2015-11-23 17:35:58,674 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.8988764044944 17:35:58 INFO - 2015-11-23 17:35:58,675 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5000 17:35:58 INFO - 2015-11-23 17:35:58,675 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1986.111111111111 17:35:58 INFO - 2015-11-23 17:35:58,675 DEBUG : BROWSER_OUTPUT: |5;Earley;782.4726134585289 17:35:58 INFO - 2015-11-23 17:35:58,675 DEBUG : BROWSER_OUTPUT: |6;Boyer;12317.073170731708 17:35:58 INFO - 2015-11-23 17:35:58,675 DEBUG : BROWSER_OUTPUT: |7;RegExp;26789.473684210527 17:35:58 INFO - 2015-11-23 17:35:58,675 DEBUG : BROWSER_OUTPUT: |8;Splay;609.726443768997 17:35:58 INFO - 2015-11-23 17:35:58,675 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4878.048780487805 17:35:58 INFO - 2015-11-23 17:35:58,675 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:35:58 INFO - 2015-11-23 17:35:58,676 DEBUG : BROWSER_OUTPUT: __startTimestamp1448328958672__endTimestamp 17:35:58 INFO - 2015-11-23 17:35:58,676 DEBUG : BROWSER_OUTPUT: 17:35:58 INFO - 2015-11-23 17:35:58,676 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:35:58 INFO - 2015-11-23 17:35:58,676 DEBUG : BROWSER_OUTPUT: Number of tests: 10 17:35:58 INFO - 2015-11-23 17:35:58,677 DEBUG : BROWSER_OUTPUT: 17:35:58 INFO - 2015-11-23 17:35:58,677 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:191.09 Median:191.09 stddev:0.00 (0.0%) 17:35:58 INFO - 2015-11-23 17:35:58,677 DEBUG : BROWSER_OUTPUT: Values: 191.1 17:35:58 INFO - 2015-11-23 17:35:58,677 DEBUG : BROWSER_OUTPUT: 17:35:58 INFO - 2015-11-23 17:35:58,678 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.29 Median:186.29 stddev:0.00 (0.0%) 17:35:58 INFO - 2015-11-23 17:35:58,678 DEBUG : BROWSER_OUTPUT: Values: 186.3 17:35:58 INFO - 2015-11-23 17:35:58,678 DEBUG : BROWSER_OUTPUT: 17:35:58 INFO - 2015-11-23 17:35:58,678 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.90 Median:280.90 stddev:0.00 (0.0%) 17:35:58 INFO - 2015-11-23 17:35:58,678 DEBUG : BROWSER_OUTPUT: Values: 280.9 17:35:58 INFO - 2015-11-23 17:35:58,679 DEBUG : BROWSER_OUTPUT: 17:35:58 INFO - 2015-11-23 17:35:58,679 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5000.00 Median:5000.00 stddev:0.00 (0.0%) 17:35:58 INFO - 2015-11-23 17:35:58,679 DEBUG : BROWSER_OUTPUT: Values: 5000.0 17:35:58 INFO - 2015-11-23 17:35:58,679 DEBUG : BROWSER_OUTPUT: 17:35:58 INFO - 2015-11-23 17:35:58,679 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1986.11 Median:1986.11 stddev:0.00 (0.0%) 17:35:58 INFO - 2015-11-23 17:35:58,679 DEBUG : BROWSER_OUTPUT: Values: 1986.1 17:35:58 INFO - 2015-11-23 17:35:58,679 DEBUG : BROWSER_OUTPUT: 17:35:58 INFO - 2015-11-23 17:35:58,679 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:782.47 Median:782.47 stddev:0.00 (0.0%) 17:35:58 INFO - 2015-11-23 17:35:58,679 DEBUG : BROWSER_OUTPUT: Values: 782.5 17:35:58 INFO - 2015-11-23 17:35:58,680 DEBUG : BROWSER_OUTPUT: 17:35:58 INFO - 2015-11-23 17:35:58,680 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12317.07 Median:12317.07 stddev:0.00 (0.0%) 17:35:58 INFO - 2015-11-23 17:35:58,680 DEBUG : BROWSER_OUTPUT: Values: 12317.1 17:35:58 INFO - 2015-11-23 17:35:58,680 DEBUG : BROWSER_OUTPUT: 17:35:58 INFO - 2015-11-23 17:35:58,680 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26789.47 Median:26789.47 stddev:0.00 (0.0%) 17:35:58 INFO - 2015-11-23 17:35:58,680 DEBUG : BROWSER_OUTPUT: Values: 26789.5 17:35:58 INFO - 2015-11-23 17:35:58,680 DEBUG : BROWSER_OUTPUT: 17:35:58 INFO - 2015-11-23 17:35:58,680 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:609.73 Median:609.73 stddev:0.00 (0.0%) 17:35:58 INFO - 2015-11-23 17:35:58,680 DEBUG : BROWSER_OUTPUT: Values: 609.7 17:35:58 INFO - 2015-11-23 17:35:58,680 DEBUG : BROWSER_OUTPUT: 17:35:58 INFO - 2015-11-23 17:35:58,681 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4878.05 Median:4878.05 stddev:0.00 (0.0%) 17:35:58 INFO - 2015-11-23 17:35:58,681 DEBUG : BROWSER_OUTPUT: Values: 4878.0 17:35:58 INFO - 2015-11-23 17:35:58,681 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:35:58 INFO - 2015-11-23 17:35:58,681 DEBUG : BROWSER_OUTPUT: 17:35:59 INFO - 2015-11-23 17:35:59,625 INFO : Browser exited with error code: 0 17:35:59 INFO - 2015-11-23 17:35:59,640 INFO : Completed test v8_7 (00:00:40) 17:36:00 INFO - 2015-11-23 17:36:00,117 INFO : Completed test suite (00:20:20) 17:36:00 INFO - 2015-11-23 17:36:00,117 DEBUG : Working with test: dromaeo_css 17:36:00 INFO - 2015-11-23 17:36:00,117 DEBUG : Generating results file: dromaeo_css 17:36:00 INFO - 2015-11-23 17:36:00,118 DEBUG : Working with test: kraken 17:36:00 INFO - 2015-11-23 17:36:00,118 DEBUG : Generating results file: kraken 17:36:00 INFO - 2015-11-23 17:36:00,119 INFO : javascript benchmark 17:36:00 INFO - 2015-11-23 17:36:00,119 DEBUG : Working with test: v8_7 17:36:00 INFO - 2015-11-23 17:36:00,119 DEBUG : Generating results file: v8_7 17:36:00 INFO - 2015-11-23 17:36:00,119 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:36:00 INFO - 2015-11-23 17:36:00,183 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,94,35]] 17:36:00 INFO - 2015-11-23 17:36:00,184 DEBUG : process_Request line: dromaeo_css 6131.43 graph.html#tests=[[72,94,35]] 17:36:00 INFO - 2015-11-23 17:36:00,184 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:36:00 INFO - 2015-11-23 17:36:00,212 DEBUG : process_Request line: kraken 1538.40 graph.html#tests=[[232,94,35]] 17:36:00 INFO - 2015-11-23 17:36:00,212 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:36:00 INFO - 2015-11-23 17:36:00,247 DEBUG : process_Request line: v8_7 19551.72 graph.html#tests=[[230,94,35]] 17:36:00 INFO - 2015-11-23 17:36:00,249 INFO : javascript benchmark 17:36:00 INFO - 2015-11-23 17:36:00,252 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2616.2805228562147, 2677.5180467515866, 2680.5845094010433, 2694.9893789828825, 2717.646705928229, 4519.615832654228, 4635.466921304051, 4648.860534183971, 4656.324832899232, 4666.206744853374, 4582.541745825416, 4626.676132670715, 4673.485916549185, 4690.882727931804, 4817.205161148407, 4285.250081235787, 4298.957010429887, 4303.397524346594, 4326.480822301328, 4338.023944612469, 4090.6318431341174, 4338.392625032498, 4353.608175264226, 4399.472063352402, 4409.272470042439, 4192.24539582875, 4216.873493795191, 4250.553691862341, 4350.564943505656, 4392.099619577979, 4337.132573485315, 4337.1976184405985, 4344.978275108636, 4358.629516491071, 4380.102079073814, 4298.527162012176, 4313.072689371768, 4318.1363727254675, 4348.782560871975, 4357.433533640607, 4413.3821265022925, 4479.641628669699, 4494.7977341019405, 4531.365608814768, 4539.523350048264, 5021.748912554358, 5054.267131265946, 5055.191169412913, 5055.873603159914, 5059.316992206079, 5015.122353588107, 5082.415522214956, 5099.413567439755, 5128.820491282824, 5129.12804823181, 4555.977220113945, 4674.462436819741, 4684.882877928011, 4686.367340409035, 4723.48041715411, 4994.0511302853065, 5027.245913113063, 5037.29477873098, 5046.091703493406, 5072.695638261643, 4856.635752318591, 4858.198397264482, 4868.902621947541, 4868.9756551217015, 4907.754612269372, 4819.566239038433, 4914.557689807934, 4921.188003979375, 4971.328870602495, 5024.171011783088, 4939.53074457926, 5013.523715247045, 5036.445990940993, 5038.269450929594, 5099.413567439792, 4927.630427717935, 4931.876703082452, 4931.9753401232765, 4932.53140951609, 4978.800847966113, 4011.0574015106426, 4058.1477889643506, 4100.65144462724, 4185.039526476788, 4204.07510347723, 3594.892153235407, 3623.3115708015393, 3667.94498082529, 3669.2661467706566, 3694.390425579803, 4371.475422949266, 4396.868093957187, 4397.802098905557, 4408.184485870061, 4432.889177770581, 4838.177509823338, 4936.703797772145, 5079.390473143247, 5091.287219789232, 5136.820211292662, 4268.850590229327, 4281.785910704452, 4353.325234588644, 4364.279893817485, 4370.950971766817, 4430.689851710349, 4431.734095954189, 4439.600435960779, 4446.044100518404, 4476.082403107355, 4766.45185803637, 4770.54679805411, 4770.9980904010545, 4771.880702982453, 4809.927851082237, 4830.347903033045, 4887.095887260868, 4949.480304567968, 4953.108440480748, 5000.274960130833, 4785.138675038526, 4808.831690890802, 4816.783244754065, 4823.421189457287, 4858.732769697701, 4990.925136122888, 4991.575716064175, 4993.550580447777, 4996.275540046746, 5026.572741317029, 4792.904141917212, 4885.682430641997, 4907.9263811043575, 4914.0908931847725, 4986.975065124651, 4884.609231261419, 4915.852524424273, 4927.827526036572, 4930.0, 4957.925631115609, 4899.069176856386, 4914.950850491592, 4920.360353154067, 4921.655484116078, 4960.20636698141, 4544.295634176708, 4646.303054541846, 4733.810647574059, 4744.691595046311, 4745.6203503718925, 4739.241721324572, 4964.8758781030765, 4966.900661986812, 4969.180085285887, 4971.030649023406, 4854.150523658275, 4854.344663470528, 4854.514548545118, 4854.635902307412, 4856.1987272099705], "unit": "ms", "name": "dojo.html", "value": 4586.601907645956}, {"lowerIsBetter": false, "replicates": [543.3371287029823, 553.8947599956008, 555.9777608895645, 562.2522045679247, 575.5855783835636, 25207.49585008299, 25924.87037564814, 36747.448788268164, 37532.43701344475, 37538.624613753855, 39558.802205989, 40187.19625607486, 40238.59761402385, 40263.19473610526, 40286.19427611446, 6809.59142451452, 7012.719491220345, 7911.841763164748, 8023.077346105185, 8089.150639182889, 10152.492375381238, 10407.37555746654, 10421.0, 10436.582536698523, 10439.686809395731, 10022.098011178992, 10115.848262276071, 10125.645602403918, 10130.240231982594, 10136.797264054714, 6851.246362900102, 7036.577805331645, 10025.54885030168, 10031.0, 10251.84622230667, 9751.3661611995, 9886.80226395468, 9913.603455861758, 9926.057024582726, 9940.25448091396, 36908.077298067496, 37413.0, 37477.25045499102, 37499.4375084374, 37574.43638345427, 2749.312671832042, 2758.213909035915, 2782.721727827201, 2797.202797202787, 2823.520001599733, 27689.723102769116, 27794.386729725207, 27847.303817404525, 28100.578491322645, 28561.85719071412, 3379.8310084495924, 3523.453864650983, 3564.108972756811, 3568.7858728476376, 3717.3866312058476, 223689.0, 226305.0, 226651.0, 226863.0, 227277.0, 40303.39544906829, 40759.0, 54819.725901370235, 55818.44181558213, 56879.0, 51431.0, 51468.48531514712, 51728.74135629298, 51855.48144518582, 51857.48142518602, 13621.795673064911, 13816.447342106203, 13818.37817298224, 13830.23933683637, 13831.723365532835, 10539.051485366354, 10606.734831629272, 10612.734681633021, 10619.150467962545, 10735.194860385502, 18662.906685466485, 18733.81266187348, 18779.624407512045, 18800.34198803035, 18815.0, 7504.362129219077, 7711.18296443253, 7744.380449564022, 7929.841403172019, 7948.721794737156, 870.4385671242013, 884.5002573546054, 916.0564618443015, 946.6923249943795, 949.2168960607527, 25942.481150377265, 26132.608010879852, 26257.343566410993, 26371.868140659557, 26516.337091572866, 936.878205833251, 957.4638202606424, 960.3229723045237, 968.3076600230869, 1029.0584115534202, 13856.237906915216, 13862.168269903837, 13891.722165556632, 14029.719405612035, 14990.175540345168, 317968.0, 323296.0, 323926.0, 326014.0, 326184.0, 48719.0, 48929.0, 49089.263661045115, 49136.75431622891, 49213.753931230116, 1197.6466942252057, 1217.5555922088552, 1227.699213692651, 1229.5450683247257, 1241.0567968343944, 26495.0, 27306.726932730417, 27401.58897616577, 27949.301267468476, 27961.16116516508, 39226.0, 39690.0, 39715.2056958865, 39718.0, 39749.0, 240244.0, 242450.0, 290168.0, 295965.0, 305813.0, 28536.85731571329, 28732.71267287384, 28757.0, 29015.419691606472, 29220.7077929218, 36874.0, 37772.62227377691, 37964.893169269504, 38359.80820095882, 38361.61638383692, 22228.444288892908, 32040.198995025312, 32543.51184732278, 32621.673783262813, 33066.7013288271, 24510.264692059267, 29199.0, 29232.41535169327, 29350.41299174047, 37170.6282937178, 33713.494297585064, 34131.317373652884, 34324.14189645279, 34491.0, 34847.0, 30138.69861301359, 31114.0, 31335.68664313328, 31755.0, 31806.204844879063, 24520.386990325384, 24542.0, 24658.260252192464, 24835.379115522257, 25032.874835625706], "unit": "ms", "name": "ext.html", "value": 17238.761058992855}, {"lowerIsBetter": false, "replicates": [330.86434561829657, 332.6424094098844, 336.9780964237325, 337.1100295220618, 337.1840146844636, 14955.0, 15334.38662453502, 15428.305726242304, 16078.356865725385, 16081.758773618376, 9983.800323993515, 13380.0, 13616.931915340434, 13635.181889086662, 13669.93165034176, 4379.5182529921685, 4507.278835386339, 4512.9097418051615, 4515.367848501212, 4515.61617262533, 4490.775461226942, 4525.592696657301, 4530.592246697796, 4536.77316134192, 4548.5224051474615, 2982.075556577457, 3070.140360699008, 4525.660575456837, 4691.225947718623, 4895.730734809584, 4986.9750651246695, 4992.950070499285, 5005.6996580205305, 5023.899522009558, 5036.4208116066575, 4755.476897541268, 4808.278758186265, 4826.227803551415, 4831.371921650198, 4916.53292937174, 9394.34239603228, 9622.663206787729, 9723.319367644268, 10007.399556026661, 10053.346532475365, 1775.9200835962413, 1779.9288028478845, 1824.5438640339914, 1836.40316897009, 1844.0687452836366, 8484.78788030298, 8570.528620925847, 8660.956695216484, 8923.15230053144, 8998.86501702475, 1706.8890522116023, 1736.6353065856185, 1770.0972504022911, 1771.503978885914, 1772.8049914509393, 51471.22793158068, 52424.47575524234, 53827.73086134584, 54256.186157207674, 54633.9999999996, 9276.257899368034, 9411.576479058458, 9424.670136545188, 9449.669261575811, 9512.90487095134, 11881.22772019816, 11912.0, 11941.64175074749, 11954.52181912731, 11970.58102966392, 6943.756968506078, 6992.440604751608, 7001.684924178424, 7014.298570143047, 7125.89311160333, 6668.799936001928, 6682.498812588978, 6696.497762667819, 6726.058351830748, 6727.66361681914, 3964.801759911993, 4030.2544029354663, 4031.3952907064177, 4038.5355684096703, 4076.673866090765, 1630.7146249406544, 1647.6045749020388, 1669.0569828047358, 1679.8320167983104, 1695.788026496688, 642.3929386729495, 817.3869597801648, 879.7536689726886, 880.308957468397, 887.4763889305211, 13026.41381137851, 14900.925495372454, 15807.288672009787, 16244.269007894673, 16339.918300408659, 801.7474495533888, 821.168334561796, 860.6944534690094, 910.5128756115447, 933.5145724223502, 8327.292180164754, 8386.706465273808, 8688.609012594448, 8693.391462597683, 8830.205281524693, 508451.0, 510014.0, 516812.0, 517260.0, 518347.0, 39699.0, 50214.0, 51626.48373516217, 65968.67015664987, 68782.65608671925, 1074.3178081918038, 1075.102289588187, 1114.637742733615, 1133.971650708739, 1137.8748337682848, 14056.226907520184, 14530.782038269223, 14568.562943111723, 14685.192314422382, 14859.628509286922, 30365.240868978453, 31119.68880311168, 31990.84004579962, 32704.182395440304, 32759.344813104082, 40106.59893401029, 42036.36945445882, 42273.365899510914, 42672.78663606662, 43215.56784432115, 8219.178082191973, 8707.129287071495, 8912.019677835304, 8934.597943092707, 8942.016378198523, 9943.701688949342, 9958.053984871425, 10001.849972250277, 10017.098461138532, 10089.0, 11817.763644727229, 13564.897440896677, 13772.655683607589, 13884.444622215402, 14266.857331426552, 12822.422990965242, 12964.638712935006, 13637.318134093453, 13825.239611821446, 13969.30153492301, 13402.17980669251, 13443.46226150943, 13551.796723048965, 13611.795823062464, 13977.0, 8409.83180336402, 8451.746447606582, 8681.392302538761, 8701.17338852808, 8711.78220544466, 12090.214136081127, 12240.143189976972, 12465.065120116209, 12617.242965422103, 12838.55065072718], "unit": "ms", "name": "jquery.html", "value": 7718.865801295449}, {"lowerIsBetter": false, "replicates": [1087.5106202209008, 1356.6879617687932, 1417.54638515675, 1489.218160465756, 1673.6067024249307, 5813.098969659704, 6451.258105317884, 6629.138212032429, 6637.170353705781, 6661.533692641517, 6550.246721627014, 6573.638449885254, 6653.0, 6676.76631317904, 6691.933080669191, 1945.4649971257911, 2004.8496362772778, 2006.2877678424168, 2006.5585571174317, 2008.5079155606898, 2014.264793350431, 2015.3550863723615, 2027.7262569553143, 2045.2125931516325, 2054.3426103646766, 1971.4775584470055, 1986.9403917882414, 2002.879827210372, 2004.4187185716125, 2005.5487515309085, 2020.3433883987689, 2028.3914825552276, 2031.1164643380102, 2032.7154198412309, 2034.4201902457728, 1969.3402710092137, 1992.3325685895243, 2016.939491815248, 2018.9798102018938, 2019.5052212208102, 5539.086050801613, 5665.0, 6737.528373013891, 6781.966090169567, 6783.559068660521, 3827.2919509890758, 3900.2979463696524, 3924.7448915820382, 3931.2923673738715, 3932.410138479251, 2626.6979297380853, 2662.2811840802874, 2691.5155272051024, 2694.178275625933, 2695.460907818444, 870.6125774030559, 887.4497811357, 892.8392889279927, 914.2503147419119, 937.7983733497331, 8741.431806932593, 8845.027047024822, 8859.24696400813, 8861.911380886173, 8866.601002954883, 3752.549694036733, 3765.3222419964122, 3775.679067279312, 3808.8286027128847, 3818.0, 7722.111957125003, 7732.878732583744, 7755.573443460664, 7766.951461552618, 7778.727744529027, 4051.6353528182603, 4054.493188351456, 4059.1475790083823, 4097.7746223957965, 4124.484439445069, 3659.524261845943, 3705.277470893204, 3707.925841483155, 3712.2575484903127, 3713.3316003119157, 3063.9846800765854, 3116.376724655078, 3140.057982605255, 3142.5757522734593, 3143.528470729363, 880.2078129683208, 880.4717169698258, 883.5052370672444, 886.4902680958475, 892.0811564088999, 801.7714951238986, 808.934918858975, 1135.1316243074054, 1141.303804679145, 1142.5429828068839, 6063.484603808637, 6202.937970620326, 6210.596311239755, 6211.689415529206, 6213.5339849511465, 406.69701072701025, 414.3784323514728, 414.4839674605136, 417.4031135476237, 433.2915682858549, 4690.155771961012, 4992.375953005874, 5017.874553136127, 5050.823221187241, 5057.949420505822, 6966.721331146799, 7846.0, 8021.398395120389, 8100.392470564731, 8119.188081191952, 7888.881666775003, 7923.445358824827, 7949.841003179904, 7955.4033447491665, 7957.403194760301, 6234.688265586702, 6296.716647750863, 6298.968505157445, 6335.841603959846, 6352.333005034498, 6216.067589861557, 6218.284897236876, 6219.626822390671, 6223.719932602953, 6236.937630623635, 6995.615241161785, 7275.054242948383, 7356.080489938758, 7377.926220737724, 7396.852062958818, 7297.963510182415, 7380.409567234716, 7410.62946852666, 7471.589062601609, 7505.437092217996, 5795.913061304, 5800.071988481823, 5852.063669812809, 5871.6770577618645, 5873.500752436091, 6625.801225963229, 6649.434798042221, 6673.1992160941, 6683.799486015428, 6683.9331606685255, 6189.1025801257665, 6212.347703491068, 6275.623462592259, 6303.6532990685955, 6341.017142342944, 5975.850603734942, 6119.265688117454, 6214.285357183981, 6215.81352559424, 6219.0, 6122.5408094392205, 6277.874442511215, 6287.591306565058, 6298.0, 6298.338674439301, 5774.0761478163295, 5809.070548712186, 5828.446297601721, 5831.650100993954, 5865.354810970704, 5872.706364681663, 5927.110933360031, 5933.317668468181, 5940.970295148497, 5978.013627751372], "unit": "ms", "name": "mootools.html", "value": 3792.0973179418606}, {"lowerIsBetter": false, "replicates": [302.7986389051281, 312.2583863324604, 315.5976130433696, 316.44306021402326, 317.9189306726787, 5297.4702529747055, 5345.652532585379, 5346.010987967229, 5417.891642167155, 5421.241026256327, 5361.678299302035, 5383.703896285702, 5386.78452861886, 5387.946120538793, 5392.460753924605, 3909.5113110861143, 4027.0, 4194.140201258735, 4194.286971214886, 4197.328427451608, 4061.025353915054, 4176.958230417703, 4183.3515805050265, 4195.496540415154, 4195.7063005589625, 4146.025683964281, 4147.191297696951, 4150.854720084798, 4154.106867023589, 4156.085661154541, 3890.9221815563674, 4026.7583944963394, 4027.818748156311, 4107.691923105749, 4151.750894946313, 3644.2164934538937, 3646.361886669822, 3646.6535679110707, 3651.233241019389, 3657.3233951719017, 5191.8442446726285, 5194.896102077937, 5204.869878253074, 5208.9582083583055, 5216.817411390621, 4795.0, 4799.640026997954, 4800.927986080212, 4806.399200099988, 4806.774272560475, 5527.50252477279, 5622.746976386073, 5654.46282603152, 5668.518175955049, 5674.00704876645, 4004.8598299059686, 4006.559278479365, 4008.997750562359, 4009.3785463253244, 4020.7386519876113, 5965.970170149121, 5974.044152935509, 5976.940230597682, 5978.372270911578, 5987.64074155552, 4135.007598176416, 4136.524299705512, 4139.81370838313, 4140.337545992687, 4152.647025002848, 4103.302438585448, 4190.790460476964, 4201.516825565099, 4208.789560521962, 4231.978840105779, 4770.308305295713, 4773.856784296477, 4776.259679749644, 4777.95222047775, 4779.832705855279, 5649.858753531113, 5660.122680984454, 5660.518855897212, 5665.065264231355, 5667.489925906688, 1461.7368873602854, 1494.9327280272414, 1497.4384605772834, 1497.4758834408087, 1500.167407089076, 1022.3967858963099, 1023.2734758321526, 1026.6560702164709, 1036.8600238967642, 1059.1526778577108, 4970.130227210224, 5003.499650034967, 5008.273800298936, 5011.874703132378, 5016.623753218523, 5890.646561206341, 5898.823035308862, 5900.704964751745, 5902.4097590240635, 5904.586678932434, 5000.1749711297225, 5003.424606170337, 5005.0240203160765, 5006.549410553068, 5009.549140577293, 2946.145617770865, 3014.0, 3141.3874294512807, 3157.1475701560908, 3187.856546455415, 5534.723263836792, 5619.8595035123635, 5626.212330273765, 5627.409122042209, 5635.8591035224445, 6087.3303936566945, 6102.176206212104, 6102.572819902653, 6115.235595550556, 6115.694215289218, 5613.0, 5623.156526520973, 5623.550115990711, 5625.071863142535, 5630.042892708249, 5788.334341550775, 5891.23413956183, 5926.496247818811, 5929.762809487745, 5931.288245410578, 5765.509931655689, 5767.509761670305, 5773.451522105393, 5782.479576838105, 5783.19035335045, 5592.664440133605, 5595.692236927008, 5597.6641401516035, 5599.04816181242, 5605.32736071674, 4077.368007958771, 4165.354370072643, 4169.312063509608, 4170.72890262132, 4189.16216756656, 5890.793822216202, 5892.469677729025, 5907.527397808251, 5913.615614985012, 5920.319163296103, 5694.487496125369, 5703.971480142573, 5707.315122185364, 5708.828735137952, 5712.742926568398, 5590.217369568182, 5692.686902220417, 5698.487136157766, 5700.315962084576, 5718.085106382959, 5531.861703457445, 5552.750126244248, 5552.972235138798, 5555.000099982042, 5558.305211848519, 5732.369439361751, 5733.369329373849, 5741.224934633771, 5744.540436765133, 5746.683932383759, 5326.467353264798, 5421.05131601976, 5522.696251706034, 5527.944720552743, 5533.363663178625], "unit": "ms", "name": "prototype.html", "value": 4278.959271175609}, {"lowerIsBetter": false, "replicates": [656.4223483334665, 669.4109183918151, 700.2437367642946, 726.5749536521134, 761.2615762710169, 11101.111911047117, 11361.772764544714, 11379.260348077369, 11390.0, 11404.429778511083, 12813.167144135625, 13018.60944171674, 13033.218006919567, 13103.868961310383, 13106.279154646514, 546.8523498655361, 553.0266730554233, 759.5101159751956, 773.5242825662206, 775.5540564175593, 554.1134185303522, 757.6249756370604, 773.3967505345811, 774.1097737601747, 774.7365895595497, 796.8406318736247, 805.1264378149715, 810.8256724804166, 811.0186674124317, 811.2739098506833, 549.0446622876207, 556.0907915558051, 794.51931581393, 802.8880001198324, 806.7660378490231, 601.7893737191991, 601.8946684330268, 602.6474512410246, 602.677567501389, 602.7769725201659, 11899.345535995517, 11977.520899164023, 11985.580504682293, 11986.220895641756, 11993.94003029988, 10252.846207306897, 10746.570137194503, 11134.721631959184, 11330.0, 11409.144314176387, 8521.0, 8704.303655707528, 8723.563821808948, 8754.69358572447, 9467.195288400495, 3014.623172103487, 3016.743576795975, 3037.9822759375634, 3043.433047939259, 3084.3985422842557, 39588.60411395878, 40616.187676246605, 40701.59298407008, 40764.0, 40926.38610420816, 8906.821863562693, 9186.908130918739, 9232.676856309998, 9266.0, 9279.860802087975, 13636.0, 13637.0, 13658.385372658255, 13665.931670341584, 13680.31598420075, 6059.424354686298, 6218.968905155445, 6312.779052733133, 6357.4914006879335, 6501.707423165969, 3500.964990350064, 3521.3837578423672, 3563.893083207456, 3574.1779390740276, 3625.220577575834, 2641.8546979915905, 2700.486907487571, 2701.392186757964, 2707.837529748221, 2715.212588349396, 464.59580165256443, 465.5646970082983, 476.24752890433035, 476.4592187866727, 484.1285685765608, 451.6499712722666, 452.93658887755083, 480.03033871579913, 546.0989367543585, 553.4327314502667, 7213.49505534618, 7281.344678978918, 7453.329200371993, 7471.7758467244985, 7476.775696729107, 424.6920982287817, 432.6949500602068, 495.74716894384125, 538.8087229033715, 548.8216329692866, 3405.1146701857697, 3504.649535046526, 3635.9636403636155, 3783.6027217141805, 3796.620337966181, 51458.48541514537, 51896.74051629718, 51898.0, 51991.0, 51998.22002669963, 43761.78119109384, 44839.327410088874, 44847.10305793866, 44897.55102448934, 45345.0, 40725.59274407218, 41051.0, 41374.58625413768, 41396.172076558905, 41865.79067104645, 6667.666616669244, 6724.260331363448, 6828.453723701992, 6862.416694581017, 6957.8956315654295, 30683.0, 31132.844335778176, 31694.683053169174, 31704.207394815316, 32027.83986080148, 37109.81445092757, 37322.813385932895, 39819.0, 41331.7933410331, 41773.791131045364, 8401.0, 8568.742937711879, 8672.349573781865, 8871.556422178735, 9034.322425817958, 9019.864702029607, 9264.907350926675, 9321.067893210897, 9455.905440945502, 9722.708318750449, 9489.193418559224, 9504.19214366759, 9661.46861922601, 9694.46680432583, 10065.547050382604, 8945.329100317373, 9022.368434209542, 9128.317639642475, 9173.036831132635, 9180.0, 8815.955920220358, 8821.867671985054, 8940.73177804667, 9125.31560133006, 9129.680461183827, 7614.8096297593, 7847.254510821463, 7868.72459463916, 7930.920690793018, 7951.642176102205, 7053.682584283617, 7609.2010338913615, 7778.92221077782, 7915.0897646771355, 7961.16407777175], "unit": "ms", "name": "yui.html", "value": 5364.807253771426}], "name": "dromaeo_css", "value": 6131.429553373424}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 116.0, 107.0, 115.0, 115.0, 115.0, 104.0, 115.0, 114.0, 103.0], "unit": "ms", "name": "ai-astar", "value": 111.8}, {"lowerIsBetter": true, "replicates": [159.0, 137.0, 161.0, 167.0, 136.0, 157.0, 152.0, 131.0, 172.0, 131.0], "unit": "ms", "name": "audio-beat-detection", "value": 150.3}, {"lowerIsBetter": true, "replicates": [165.0, 162.0, 163.0, 163.0, 163.0, 162.0, 165.0, 163.0, 161.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 162.9}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 85.0, 104.0, 74.0, 72.0, 76.0, 108.0, 87.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 82.5}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 144.0, 94.0, 94.0, 95.0, 136.0, 96.0, 95.0, 131.0], "unit": "ms", "name": "audio-oscillator", "value": 107.4}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 110.0, 109.0, 110.0, 110.0, 110.0, 110.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [147.0, 148.0, 148.0, 146.0, 147.0, 147.0, 147.0, 148.0, 148.0, 148.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.4}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 73.0, 71.0, 72.0, 72.0, 72.0, 82.0, 71.0, 71.0], "unit": "ms", "name": "json-parse-financial", "value": 72.7}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 70.0, 71.0, 71.0, 70.0, 70.0, 71.0, 71.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 70.4}, {"lowerIsBetter": true, "replicates": [82.0, 90.0, 84.0, 84.0, 82.0, 84.0, 85.0, 85.0, 85.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.4}, {"lowerIsBetter": true, "replicates": [122.0, 127.0, 122.0, 119.0, 131.0, 142.0, 123.0, 123.0, 122.0, 122.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 125.3}, {"lowerIsBetter": true, "replicates": [151.0, 146.0, 149.0, 160.0, 152.0, 143.0, 156.0, 154.0, 143.0, 139.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 149.3}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 69.0, 68.0, 69.0, 69.0, 69.0, 69.0, 69.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.0}], "name": "kraken", "value": 1538.4}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [191.0949742021785], "unit": "score", "name": "Richards", "value": 184.73536599999997}, {"lowerIsBetter": false, "replicates": [186.28912071535024], "unit": "score", "name": "DeltaBlue", "value": 354.92142400000006}, {"lowerIsBetter": false, "replicates": [280.8988764044944], "unit": "score", "name": "Encrypt", "value": 947.6043599999998}, {"lowerIsBetter": false, "replicates": [5000.0], "unit": "score", "name": "Decrypt", "value": 53.23619999999997}, {"lowerIsBetter": false, "replicates": [1986.111111111111], "unit": "score", "name": "RayTrace", "value": 372.5818741258742}, {"lowerIsBetter": false, "replicates": [782.4726134585289], "unit": "score", "name": "Earley", "value": 851.7397139999999}, {"lowerIsBetter": false, "replicates": [12317.073170731708], "unit": "score", "name": "Boyer", "value": 54.108877227722786}, {"lowerIsBetter": false, "replicates": [26789.473684210527], "unit": "score", "name": "RegExp", "value": 34.0053339882122}, {"lowerIsBetter": false, "replicates": [609.726443768997], "unit": "score", "name": "Splay", "value": 133.651739780658}, {"lowerIsBetter": false, "replicates": [4878.048780487805], "unit": "score", "name": "NavierStokes", "value": 304.2200000000002}], "name": "v8_7", "value": 19551.72208892262}]} 17:36:00 INFO - RETURN: dromaeo_css: 6131.43 17:36:00 INFO - RETURN: kraken: 1538.40 17:36:00 INFO - RETURN: v8_7: 19551.72 17:36:00 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,35]]", "result": "19551.72"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,35]]", "result": "1538.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,35]]", "result": "6131.43"}}} 17:36:00 INFO - Return code: 0 17:36:00 INFO - # TBPL SUCCESS # 17:36:00 INFO - Running post-action listener: _resource_record_post_action 17:36:00 INFO - Running post-run listener: _resource_record_post_run 17:36:01 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 4096; Write bytes: 497340416; Read time: 108; Write time: 584900 17:36:01 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 170975232; Read time: 0; Write time: 166392 17:36:01 INFO - run-tests - Wall time: 1221s; CPU: 13.0%; Read bytes: 0; Write bytes: 273473536; Read time: 0; Write time: 270804 17:36:01 INFO - Running post-run listener: _upload_blobber_files 17:36:01 INFO - Blob upload gear active. 17:36:01 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 17:36:01 INFO - Copying logs to upload dir... 17:36:01 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1281.921957 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2015-11-23 17:36:00.155493) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 17:36:00.158761) ========= 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=0ae9de487587ba4b94dd3100000001b5-1448327602.553804-1950711028 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/vJugx6fcT02MGEw9S8KISA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010216 build_url: 'https://queue.taskcluster.net/v1/task/vJugx6fcT02MGEw9S8KISA/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-23 17:36:00.210368) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 17:36:00.210696) ========= 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=0ae9de487587ba4b94dd3100000001b5-1448327602.553804-1950711028 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004532 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 17:36:00.260140) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 17:36:00.260467) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 17:36:00.260760) ========= ========= Total master_lag: 1.31 =========