builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-039 starttime: 1447999442.41 results: success (0) buildid: 20151119205634 builduid: 704f9cb67ce845c4a415f3bc386b24e4 revision: 3835b568092ae3b71adc931d24928670ad7141a7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 22:04:02.411634) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 22:04:02.412090) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 22:04:02.412386) ========= 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=6e558709db315bacd2260379000001b6-1447997902.82259-879392377 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006556 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 22:04:02.437651) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 22:04:02.437951) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 22:04:02.450526) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 22:04:02.450811) ========= 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=6e558709db315bacd2260379000001b6-1447997902.82259-879392377 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004591 ========= master_lag: 0.35 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 22:04:02.807058) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 22:04:02.807380) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 22:04:02.807779) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 22:04:02.808057) ========= 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=6e558709db315bacd2260379000001b6-1447997902.82259-879392377 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-19 22:04:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.2M=0s 2015-11-19 22:04:03 (43.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.168102 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 22:04:02.988455) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 22:04:02.988807) ========= 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=6e558709db315bacd2260379000001b6-1447997902.82259-879392377 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016948 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 22:04:03.038928) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 22:04:03.039358) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3835b568092ae3b71adc931d24928670ad7141a7 --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 3835b568092ae3b71adc931d24928670ad7141a7 --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=6e558709db315bacd2260379000001b6-1447997902.82259-879392377 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-19 22:04:03,620 truncating revision to first 12 chars 2015-11-19 22:04:03,620 Setting DEBUG logging. 2015-11-19 22:04:03,620 attempt 1/10 2015-11-19 22:04:03,620 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3835b568092a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-19 22:04:03,967 unpacking tar archive at: mozilla-central-3835b568092a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.606905 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 22:04:03.659255) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 22:04:03.659574) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 22:04:03.668436) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 22:04:03.668787) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 22:04:03.669180) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2015-11-19 22:04:03.669466) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=6e558709db315bacd2260379000001b6-1447997902.82259-879392377 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:04:04 INFO - MultiFileLogger online at 20151119 22:04:04 in /builds/slave/test 22:04:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 22:04:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:04:04 INFO - {'append_to_log': False, 22:04:04 INFO - 'base_work_dir': '/builds/slave/test', 22:04:04 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 22:04:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:04:04 INFO - 'branch': 'Firefox-Non-PGO', 22:04:04 INFO - 'buildbot_json_path': 'buildprops.json', 22:04:04 INFO - 'config_files': ('talos/linux_config.py',), 22:04:04 INFO - 'default_actions': ('clobber', 22:04:04 INFO - 'read-buildbot-config', 22:04:04 INFO - 'download-and-extract', 22:04:04 INFO - 'populate-webroot', 22:04:04 INFO - 'create-virtualenv', 22:04:04 INFO - 'install', 22:04:04 INFO - 'run-tests'), 22:04:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:04:04 INFO - 'download_minidump_stackwalk': True, 22:04:04 INFO - 'download_symbols': 'ondemand', 22:04:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:04:04 INFO - 'tooltool.py': '/tools/tooltool.py', 22:04:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:04:04 INFO - '/tools/misc-python/virtualenv.py')}, 22:04:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:04:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:04:04 INFO - 'installer_path': 'installer.exe', 22:04:04 INFO - 'log_level': 'info', 22:04:04 INFO - 'log_name': 'talos', 22:04:04 INFO - 'log_to_console': True, 22:04:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:04:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:04:04 INFO - 'opt_config_files': (), 22:04:04 INFO - 'pip_index': False, 22:04:04 INFO - 'sps_profile': False, 22:04:04 INFO - 'sps_profile_interval': 0, 22:04:04 INFO - 'suite': 'dromaeojs-e10s', 22:04:04 INFO - 'system_bits': '64', 22:04:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:04:04 INFO - 'title': 'talos-linux64-ix-039', 22:04:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:04:04 INFO - 'use_talos_json': True, 22:04:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:04:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:04:04 INFO - 'work_dir': 'build'} 22:04:04 INFO - ##### 22:04:04 INFO - ##### Running clobber step. 22:04:04 INFO - ##### 22:04:04 INFO - Running pre-action listener: _resource_record_pre_action 22:04:04 INFO - Running main action method: clobber 22:04:04 INFO - rmtree: /builds/slave/test/build 22:04:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:04:04 INFO - Running post-action listener: _resource_record_post_action 22:04:04 INFO - ##### 22:04:04 INFO - ##### Running read-buildbot-config step. 22:04:04 INFO - ##### 22:04:04 INFO - Running pre-action listener: _resource_record_pre_action 22:04:04 INFO - Running main action method: read_buildbot_config 22:04:04 INFO - Using buildbot properties: 22:04:04 INFO - { 22:04:04 INFO - "properties": { 22:04:04 INFO - "buildnumber": 113, 22:04:04 INFO - "product": "firefox", 22:04:04 INFO - "script_repo_revision": "production", 22:04:04 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 22:04:04 INFO - "repository": "", 22:04:04 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 22:04:04 INFO - "buildid": "20151119205634", 22:04:04 INFO - "slavename": "talos-linux64-ix-039", 22:04:04 INFO - "pgo_build": "False", 22:04:04 INFO - "basedir": "/builds/slave/test", 22:04:04 INFO - "project": "", 22:04:04 INFO - "platform": "ubuntu64_hw", 22:04:04 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 22:04:04 INFO - "slavebuilddir": "test", 22:04:04 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 22:04:04 INFO - "branch": "mozilla-central", 22:04:04 INFO - "repo_path": "mozilla-central", 22:04:04 INFO - "stage_platform": "linux64", 22:04:04 INFO - "builduid": "704f9cb67ce845c4a415f3bc386b24e4", 22:04:04 INFO - "revision": "3835b568092ae3b71adc931d24928670ad7141a7" 22:04:04 INFO - }, 22:04:04 INFO - "sourcestamp": { 22:04:04 INFO - "repository": "", 22:04:04 INFO - "hasPatch": false, 22:04:04 INFO - "project": "", 22:04:04 INFO - "branch": "mozilla-central-linux64-talos", 22:04:04 INFO - "changes": [ 22:04:04 INFO - { 22:04:04 INFO - "category": null, 22:04:04 INFO - "files": [ 22:04:04 INFO - { 22:04:04 INFO - "url": null, 22:04:04 INFO - "name": "https://queue.taskcluster.net/v1/task/8lMdDzBPRgevcJGbcutB5A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 22:04:04 INFO - } 22:04:04 INFO - ], 22:04:04 INFO - "repository": "", 22:04:04 INFO - "rev": "3835b568092ae3b71adc931d24928670ad7141a7", 22:04:04 INFO - "who": "philringnalda@gmail.com", 22:04:04 INFO - "when": 1447999302, 22:04:04 INFO - "number": 6686959, 22:04:04 INFO - "comments": "Backed out 2 changesets (bug 1225007) for frequent OS X \"Shouldn't return empty rect\" assertion failures, a=backout\n\nBacked out changeset c5b352c74b35 (bug 1225007)\nBacked out changeset 8a513c70ce7c (bug 1225007)", 22:04:04 INFO - "project": "", 22:04:04 INFO - "at": "Thu 19 Nov 2015 22:01:42", 22:04:04 INFO - "branch": "mozilla-central-linux64-talos", 22:04:04 INFO - "revlink": "", 22:04:04 INFO - "properties": [ 22:04:04 INFO - [ 22:04:04 INFO - "buildid", 22:04:04 INFO - "20151119205634", 22:04:04 INFO - "Change" 22:04:04 INFO - ], 22:04:04 INFO - [ 22:04:04 INFO - "builduid", 22:04:04 INFO - "704f9cb67ce845c4a415f3bc386b24e4", 22:04:04 INFO - "Change" 22:04:04 INFO - ], 22:04:04 INFO - [ 22:04:04 INFO - "pgo_build", 22:04:04 INFO - "False", 22:04:04 INFO - "Change" 22:04:04 INFO - ] 22:04:04 INFO - ], 22:04:04 INFO - "revision": "3835b568092ae3b71adc931d24928670ad7141a7" 22:04:04 INFO - } 22:04:04 INFO - ], 22:04:04 INFO - "revision": "3835b568092ae3b71adc931d24928670ad7141a7" 22:04:04 INFO - } 22:04:04 INFO - } 22:04:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/8lMdDzBPRgevcJGbcutB5A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 22:04:04 INFO - Running post-action listener: _resource_record_post_action 22:04:04 INFO - ##### 22:04:04 INFO - ##### Running download-and-extract step. 22:04:04 INFO - ##### 22:04:04 INFO - Running pre-action listener: _resource_record_pre_action 22:04:04 INFO - Running main action method: download_and_extract 22:04:04 INFO - mkdir: /builds/slave/test/build/tests 22:04:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:04 INFO - https://queue.taskcluster.net/v1/task/8lMdDzBPRgevcJGbcutB5A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:04:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8lMdDzBPRgevcJGbcutB5A/artifacts/public/build/test_packages.json 22:04:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8lMdDzBPRgevcJGbcutB5A/artifacts/public/build/test_packages.json 22:04:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8lMdDzBPRgevcJGbcutB5A/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 22:04:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8lMdDzBPRgevcJGbcutB5A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 22:04:05 INFO - Downloaded 1302 bytes. 22:04:05 INFO - Reading from file /builds/slave/test/build/test_packages.json 22:04:05 INFO - Using the following test package requirements: 22:04:05 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 22:04:05 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:04:05 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:04:05 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:04:05 INFO - u'jsshell-linux-x86_64.zip'], 22:04:05 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:04:05 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:04:05 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 22:04:05 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:04:05 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:04:05 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:04:05 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:04:05 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:04:05 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:04:05 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 22:04:05 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:04:05 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:04:05 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:04:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:05 INFO - https://queue.taskcluster.net/v1/task/8lMdDzBPRgevcJGbcutB5A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:04:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8lMdDzBPRgevcJGbcutB5A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:04:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8lMdDzBPRgevcJGbcutB5A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:04:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8lMdDzBPRgevcJGbcutB5A/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 22:04:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8lMdDzBPRgevcJGbcutB5A/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 22:04:06 INFO - Downloaded 21336489 bytes. 22:04:06 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 22:04:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:04:06 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 22:04:07 INFO - Return code: 0 22:04:07 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 22:04:07 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')]} 22:04:07 INFO - https://queue.taskcluster.net/v1/task/8lMdDzBPRgevcJGbcutB5A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:04:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8lMdDzBPRgevcJGbcutB5A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:04:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8lMdDzBPRgevcJGbcutB5A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:04:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8lMdDzBPRgevcJGbcutB5A/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 22:04:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8lMdDzBPRgevcJGbcutB5A/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 22:04:08 INFO - Downloaded 21336489 bytes. 22:04:08 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 22:04:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:04:08 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 22:04:10 INFO - Return code: 0 22:04:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:10 INFO - https://queue.taskcluster.net/v1/task/8lMdDzBPRgevcJGbcutB5A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:04:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8lMdDzBPRgevcJGbcutB5A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 22:04:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8lMdDzBPRgevcJGbcutB5A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 22:04:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8lMdDzBPRgevcJGbcutB5A/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 22:04:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8lMdDzBPRgevcJGbcutB5A/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 22:04:11 INFO - Downloaded 11130997 bytes. 22:04:11 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 22:04:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 22:04:11 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 22:04:11 INFO - Return code: 0 22:04:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:11 INFO - https://queue.taskcluster.net/v1/task/8lMdDzBPRgevcJGbcutB5A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:04:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8lMdDzBPRgevcJGbcutB5A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:04:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8lMdDzBPRgevcJGbcutB5A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:04:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8lMdDzBPRgevcJGbcutB5A/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 22:04:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8lMdDzBPRgevcJGbcutB5A/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 22:04:12 INFO - Downloaded 55781650 bytes. 22:04:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/8lMdDzBPRgevcJGbcutB5A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:04:12 INFO - mkdir: /builds/slave/test/properties 22:04:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:04:12 INFO - Writing to file /builds/slave/test/properties/build_url 22:04:12 INFO - Contents: 22:04:12 INFO - build_url:https://queue.taskcluster.net/v1/task/8lMdDzBPRgevcJGbcutB5A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:04:12 INFO - Running post-action listener: _resource_record_post_action 22:04:12 INFO - Running post-action listener: set_extra_try_arguments 22:04:12 INFO - ##### 22:04:12 INFO - ##### Running populate-webroot step. 22:04:12 INFO - ##### 22:04:12 INFO - Running pre-action listener: _resource_record_pre_action 22:04:12 INFO - Running main action method: populate_webroot 22:04:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:04:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:04:12 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 22:04:12 INFO - '../fennec_ids.txt'], 22:04:12 INFO - 'tests': ['tcheck2']}, 22:04:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:04:12 INFO - '--tppagecycles', 22:04:12 INFO - '7'], 22:04:12 INFO - 'tests': ['tsvgm']}}, 22:04:12 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:04:12 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:04:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:04:12 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:04:12 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:04:12 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:04:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:04:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:04:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:04:12 INFO - 'talos_options': ['--e10s'], 22:04:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:04:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:04:12 INFO - 'tests': ['damp', 'tps']}, 22:04:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:04:12 INFO - 'talos_options': ['--e10s'], 22:04:12 INFO - 'tests': ['damp', 'tps']}, 22:04:12 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:04:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:04:12 INFO - 'other': {'tests': ['a11yr', 22:04:12 INFO - 'ts_paint', 22:04:12 INFO - 'tpaint', 22:04:12 INFO - 'sessionrestore', 22:04:12 INFO - 'sessionrestore_no_auto_restore']}, 22:04:12 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:04:12 INFO - 'tests': ['a11yr', 22:04:12 INFO - 'ts_paint', 22:04:12 INFO - 'tpaint', 22:04:12 INFO - 'sessionrestore', 22:04:12 INFO - 'sessionrestore_no_auto_restore']}, 22:04:12 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:04:12 INFO - 'tests': ['a11yr', 22:04:12 INFO - 'ts_paint', 22:04:12 INFO - 'tpaint', 22:04:12 INFO - 'sessionrestore', 22:04:12 INFO - 'sessionrestore_no_auto_restore']}, 22:04:12 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:04:12 INFO - 'tests': ['a11yr', 22:04:12 INFO - 'ts_paint', 22:04:12 INFO - 'tpaint', 22:04:12 INFO - 'sessionrestore', 22:04:12 INFO - 'sessionrestore_no_auto_restore']}, 22:04:12 INFO - 'other_l64': {'tests': ['a11yr', 22:04:12 INFO - 'ts_paint', 22:04:12 INFO - 'tpaint', 22:04:12 INFO - 'sessionrestore', 22:04:12 INFO - 'sessionrestore_no_auto_restore']}, 22:04:12 INFO - 'other_nol64': {'tests': ['a11yr', 22:04:12 INFO - 'ts_paint', 22:04:12 INFO - 'tpaint', 22:04:12 INFO - 'sessionrestore', 22:04:12 INFO - 'sessionrestore_no_auto_restore']}, 22:04:12 INFO - 'svgr': {'tests': ['tsvgx', 22:04:12 INFO - 'tsvgr_opacity', 22:04:12 INFO - 'tart', 22:04:12 INFO - 'tscrollx', 22:04:12 INFO - 'cart']}, 22:04:12 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:04:12 INFO - 'tests': ['tsvgx', 22:04:12 INFO - 'tsvgr_opacity', 22:04:12 INFO - 'tart', 22:04:12 INFO - 'tscrollx', 22:04:12 INFO - 'cart']}, 22:04:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:04:12 INFO - 'tests': ['tp5o']}, 22:04:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:04:12 INFO - 'talos_options': ['--e10s'], 22:04:12 INFO - 'tests': ['tp5o']}, 22:04:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:04:12 INFO - 'talos_options': ['--xperf_path', 22:04:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:04:12 INFO - 'tests': ['tp5n']}, 22:04:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:04:12 INFO - 'talos_options': ['--e10s', 22:04:12 INFO - '--xperf_path', 22:04:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:04:12 INFO - 'tests': ['tp5n']}}, 22:04:12 INFO - 'talos.zip': {'path': '', 22:04:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:04:12 INFO - Running post-action listener: _resource_record_post_action 22:04:12 INFO - ##### 22:04:12 INFO - ##### Running create-virtualenv step. 22:04:12 INFO - ##### 22:04:12 INFO - Running pre-action listener: _resource_record_pre_action 22:04:12 INFO - Running main action method: create_virtualenv 22:04:12 INFO - Creating virtualenv /builds/slave/test/build/venv 22:04:12 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 22:04:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:04:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:04:12 INFO - Using real prefix '/usr' 22:04:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:04:13 INFO - Installing distribute.............................................................................................................................................................................................done. 22:04:15 INFO - Installing pip.................done. 22:04:15 INFO - Return code: 0 22:04:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:04:15 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')]} 22:04:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:04:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:15 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')]} 22:04:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:04:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:15 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 0x7f1486ce6c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f16c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18a2900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e8b70>, '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 0x1939dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x193a250>, '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': '6e558709db315bacd2260379000001b6-1447997902.82259-879392377', '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 22:04:15 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 22:04:15 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 22:04:15 INFO - Using env: {'DISPLAY': ':0', 22:04:15 INFO - 'HOME': '/home/cltbld', 22:04:15 INFO - 'LANG': 'en_US.UTF-8', 22:04:15 INFO - 'LANGUAGE': 'en_US:en', 22:04:15 INFO - 'LOGNAME': 'cltbld', 22:04:15 INFO - 'MAIL': '/var/mail/cltbld', 22:04:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:04:15 INFO - 'MOZ_NO_REMOTE': '1', 22:04:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:04:15 INFO - 'NO_EM_RESTART': '1', 22:04:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:04:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:04:15 INFO - 'PWD': '/builds/slave/test', 22:04:15 INFO - 'SHELL': '/bin/bash', 22:04:15 INFO - 'SHLVL': '1', 22:04:15 INFO - 'TERM': 'linux', 22:04:15 INFO - 'TMOUT': '86400', 22:04:15 INFO - 'USER': 'cltbld', 22:04:15 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1447997902.82259-879392377', 22:04:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:04:15 INFO - '_': '/tools/buildbot/bin/python'} 22:04:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:04:15 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 22:04:15 INFO - Cleaning up... 22:04:15 INFO - Return code: 0 22:04:15 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:04:15 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')]} 22:04:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:04:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:15 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')]} 22:04:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:04:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:15 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 0x7f1486ce6c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f16c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18a2900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e8b70>, '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 0x1939dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x193a250>, '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': '6e558709db315bacd2260379000001b6-1447997902.82259-879392377', '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 22:04:15 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 22:04:15 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 22:04:15 INFO - Using env: {'DISPLAY': ':0', 22:04:15 INFO - 'HOME': '/home/cltbld', 22:04:15 INFO - 'LANG': 'en_US.UTF-8', 22:04:15 INFO - 'LANGUAGE': 'en_US:en', 22:04:15 INFO - 'LOGNAME': 'cltbld', 22:04:15 INFO - 'MAIL': '/var/mail/cltbld', 22:04:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:04:15 INFO - 'MOZ_NO_REMOTE': '1', 22:04:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:04:15 INFO - 'NO_EM_RESTART': '1', 22:04:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:04:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:04:15 INFO - 'PWD': '/builds/slave/test', 22:04:15 INFO - 'SHELL': '/bin/bash', 22:04:15 INFO - 'SHLVL': '1', 22:04:15 INFO - 'TERM': 'linux', 22:04:15 INFO - 'TMOUT': '86400', 22:04:15 INFO - 'USER': 'cltbld', 22:04:15 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1447997902.82259-879392377', 22:04:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:04:15 INFO - '_': '/tools/buildbot/bin/python'} 22:04:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:04:15 INFO - Downloading/unpacking psutil>=0.7.1 22:04:15 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 22:04:15 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 22:04:15 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 22:04:15 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 22:04:15 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 22:04:15 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 22:04:17 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 22:04:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 22:04:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:04:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:04:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:04:17 INFO - Installing collected packages: psutil 22:04:17 INFO - Running setup.py install for psutil 22:04:17 INFO - building 'psutil._psutil_linux' extension 22:04:17 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 22:04:17 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 22:04:17 INFO - building 'psutil._psutil_posix' extension 22:04:17 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 22:04:17 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 22:04:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:04:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:04:18 INFO - Successfully installed psutil 22:04:18 INFO - Cleaning up... 22:04:18 INFO - Return code: 0 22:04:18 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:04:18 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')]} 22:04:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:04:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:18 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')]} 22:04:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:04:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:18 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 0x7f1486ce6c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f16c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18a2900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e8b70>, '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 0x1939dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x193a250>, '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': '6e558709db315bacd2260379000001b6-1447997902.82259-879392377', '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 22:04:18 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 22:04:18 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 22:04:18 INFO - Using env: {'DISPLAY': ':0', 22:04:18 INFO - 'HOME': '/home/cltbld', 22:04:18 INFO - 'LANG': 'en_US.UTF-8', 22:04:18 INFO - 'LANGUAGE': 'en_US:en', 22:04:18 INFO - 'LOGNAME': 'cltbld', 22:04:18 INFO - 'MAIL': '/var/mail/cltbld', 22:04:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:04:18 INFO - 'MOZ_NO_REMOTE': '1', 22:04:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:04:18 INFO - 'NO_EM_RESTART': '1', 22:04:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:04:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:04:18 INFO - 'PWD': '/builds/slave/test', 22:04:18 INFO - 'SHELL': '/bin/bash', 22:04:18 INFO - 'SHLVL': '1', 22:04:18 INFO - 'TERM': 'linux', 22:04:18 INFO - 'TMOUT': '86400', 22:04:18 INFO - 'USER': 'cltbld', 22:04:18 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1447997902.82259-879392377', 22:04:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:04:18 INFO - '_': '/tools/buildbot/bin/python'} 22:04:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:04:18 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:04:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:04:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:04:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:04:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:04:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:04:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:04:19 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:04:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 22:04:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:04:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:04:20 INFO - Installing collected packages: mozsystemmonitor 22:04:20 INFO - Running setup.py install for mozsystemmonitor 22:04:20 INFO - Successfully installed mozsystemmonitor 22:04:20 INFO - Cleaning up... 22:04:20 INFO - Return code: 0 22:04:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:04: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')]} 22:04:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:04:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04: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')]} 22:04:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:04:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04: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', '--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 0x7f1486ce6c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f16c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18a2900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e8b70>, '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 0x1939dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x193a250>, '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': '6e558709db315bacd2260379000001b6-1447997902.82259-879392377', '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 22:04:20 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 22:04:20 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 22:04:20 INFO - Using env: {'DISPLAY': ':0', 22:04:20 INFO - 'HOME': '/home/cltbld', 22:04:20 INFO - 'LANG': 'en_US.UTF-8', 22:04:20 INFO - 'LANGUAGE': 'en_US:en', 22:04:20 INFO - 'LOGNAME': 'cltbld', 22:04:20 INFO - 'MAIL': '/var/mail/cltbld', 22:04:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:04:20 INFO - 'MOZ_NO_REMOTE': '1', 22:04:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:04:20 INFO - 'NO_EM_RESTART': '1', 22:04:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:04:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:04:20 INFO - 'PWD': '/builds/slave/test', 22:04:20 INFO - 'SHELL': '/bin/bash', 22:04:20 INFO - 'SHLVL': '1', 22:04:20 INFO - 'TERM': 'linux', 22:04:20 INFO - 'TMOUT': '86400', 22:04:20 INFO - 'USER': 'cltbld', 22:04:20 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1447997902.82259-879392377', 22:04:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:04:20 INFO - '_': '/tools/buildbot/bin/python'} 22:04:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:04:20 INFO - Downloading/unpacking blobuploader==1.2.4 22:04:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:04:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:04:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:04:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:04:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:04:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:04:22 INFO - Downloading blobuploader-1.2.4.tar.gz 22:04:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 22:04:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:04:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:04: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 22:04: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 22:04: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 22:04: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 22:04: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 22:04: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 22:04:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 22:04:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:04:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:04: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 22:04: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 22:04: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 22:04: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 22:04: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 22:04: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 22:04:22 INFO - Downloading docopt-0.6.1.tar.gz 22:04:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 22:04:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:04:22 INFO - Installing collected packages: blobuploader, requests, docopt 22:04:22 INFO - Running setup.py install for blobuploader 22:04:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:04:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:04:23 INFO - Running setup.py install for requests 22:04:23 INFO - Running setup.py install for docopt 22:04:23 INFO - Successfully installed blobuploader requests docopt 22:04:23 INFO - Cleaning up... 22:04:23 INFO - Return code: 0 22:04:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:04:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:04:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:04:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:23 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 0x7f1486ce6c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f16c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18a2900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e8b70>, '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 0x1939dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x193a250>, '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': '6e558709db315bacd2260379000001b6-1447997902.82259-879392377', '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 22:04:23 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 22:04:23 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 22:04:23 INFO - Using env: {'DISPLAY': ':0', 22:04:23 INFO - 'HOME': '/home/cltbld', 22:04:23 INFO - 'LANG': 'en_US.UTF-8', 22:04:23 INFO - 'LANGUAGE': 'en_US:en', 22:04:23 INFO - 'LOGNAME': 'cltbld', 22:04:23 INFO - 'MAIL': '/var/mail/cltbld', 22:04:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:04:23 INFO - 'MOZ_NO_REMOTE': '1', 22:04:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:04:23 INFO - 'NO_EM_RESTART': '1', 22:04:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:04:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:04:23 INFO - 'PWD': '/builds/slave/test', 22:04:23 INFO - 'SHELL': '/bin/bash', 22:04:23 INFO - 'SHLVL': '1', 22:04:23 INFO - 'TERM': 'linux', 22:04:23 INFO - 'TMOUT': '86400', 22:04:23 INFO - 'USER': 'cltbld', 22:04:23 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1447997902.82259-879392377', 22:04:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:04:23 INFO - '_': '/tools/buildbot/bin/python'} 22:04:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:04:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:04:23 INFO - Running setup.py (path:/tmp/pip-SDRdxq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:04:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:04:23 INFO - Running setup.py (path:/tmp/pip-aPtgs5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:04:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:04:23 INFO - Running setup.py (path:/tmp/pip-jfWp1C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:04:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:04:23 INFO - Running setup.py (path:/tmp/pip-nARdZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:04:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:04:24 INFO - Running setup.py (path:/tmp/pip-V0oiiJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:04:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:04:24 INFO - Running setup.py (path:/tmp/pip-DSNoVA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:04:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:04:24 INFO - Running setup.py (path:/tmp/pip-mjE6W9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:04:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:04:24 INFO - Running setup.py (path:/tmp/pip-mjDUMD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:04:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:04:24 INFO - Running setup.py (path:/tmp/pip-gt7mps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:04:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:04:24 INFO - Running setup.py (path:/tmp/pip-fT_QOG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:04:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:04:24 INFO - Running setup.py (path:/tmp/pip-5y7q67-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:04:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:04:24 INFO - Running setup.py (path:/tmp/pip-ud6Wgo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:04:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:04:24 INFO - Running setup.py (path:/tmp/pip-G1ZxGC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:04:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:04:24 INFO - Running setup.py (path:/tmp/pip-Jkok7h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:04:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:04:24 INFO - Running setup.py (path:/tmp/pip-Z2Vsry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:04:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:04:24 INFO - Running setup.py (path:/tmp/pip-bBRTES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:04:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:04:24 INFO - Running setup.py (path:/tmp/pip-Jlj2DA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:04:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:04:24 INFO - Running setup.py install for manifestparser 22:04:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:04:25 INFO - Running setup.py install for mozcrash 22:04:25 INFO - Running setup.py install for mozdebug 22:04:25 INFO - Running setup.py install for mozdevice 22:04:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:04:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:04:25 INFO - Running setup.py install for mozfile 22:04:25 INFO - Running setup.py install for mozhttpd 22:04:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:04:25 INFO - Running setup.py install for mozinfo 22:04:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:04:25 INFO - Running setup.py install for mozInstall 22:04:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:04:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:04:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:04:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:04:25 INFO - Running setup.py install for mozleak 22:04:25 INFO - Running setup.py install for mozlog 22:04:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:04:25 INFO - Running setup.py install for moznetwork 22:04:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:04:26 INFO - Running setup.py install for mozprocess 22:04:26 INFO - Running setup.py install for mozprofile 22:04:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:04:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:04:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:04:26 INFO - Running setup.py install for mozrunner 22:04:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:04:26 INFO - Running setup.py install for mozscreenshot 22:04:26 INFO - Running setup.py install for moztest 22:04:26 INFO - Running setup.py install for mozversion 22:04:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:04:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:04:26 INFO - Cleaning up... 22:04:26 INFO - Return code: 0 22:04:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:04:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:04:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:04:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:26 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 0x7f1486ce6c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f16c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18a2900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e8b70>, '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 0x1939dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x193a250>, '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': '6e558709db315bacd2260379000001b6-1447997902.82259-879392377', '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 22:04:26 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 22:04:26 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 22:04:26 INFO - Using env: {'DISPLAY': ':0', 22:04:26 INFO - 'HOME': '/home/cltbld', 22:04:26 INFO - 'LANG': 'en_US.UTF-8', 22:04:26 INFO - 'LANGUAGE': 'en_US:en', 22:04:26 INFO - 'LOGNAME': 'cltbld', 22:04:26 INFO - 'MAIL': '/var/mail/cltbld', 22:04:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:04:26 INFO - 'MOZ_NO_REMOTE': '1', 22:04:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:04:26 INFO - 'NO_EM_RESTART': '1', 22:04:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:04:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:04:26 INFO - 'PWD': '/builds/slave/test', 22:04:26 INFO - 'SHELL': '/bin/bash', 22:04:26 INFO - 'SHLVL': '1', 22:04:26 INFO - 'TERM': 'linux', 22:04:26 INFO - 'TMOUT': '86400', 22:04:26 INFO - 'USER': 'cltbld', 22:04:26 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1447997902.82259-879392377', 22:04:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:04:26 INFO - '_': '/tools/buildbot/bin/python'} 22:04:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:04:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:04:26 INFO - Running setup.py (path:/tmp/pip-yCOF0N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:04:27 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)) 22:04:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:04:27 INFO - Running setup.py (path:/tmp/pip-IiIGXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:04:27 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)) 22:04:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:04:27 INFO - Running setup.py (path:/tmp/pip-tdeg1R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:04:27 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)) 22:04:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:04:27 INFO - Running setup.py (path:/tmp/pip-zUFgvp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:04:27 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)) 22:04:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:04:27 INFO - Running setup.py (path:/tmp/pip-246bRS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:04:27 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)) 22:04:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:04:27 INFO - Running setup.py (path:/tmp/pip-_tvS1j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:04:27 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)) 22:04:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:04:27 INFO - Running setup.py (path:/tmp/pip-de3uuY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:04:27 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)) 22:04:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:04:27 INFO - Running setup.py (path:/tmp/pip-_3n_Su-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:04:27 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)) 22:04:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:04:27 INFO - Running setup.py (path:/tmp/pip-5oxiHe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:04:27 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)) 22:04:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:04:27 INFO - Running setup.py (path:/tmp/pip-L9WErX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:04:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:04:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:04:27 INFO - Running setup.py (path:/tmp/pip-o48wBJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:04:27 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)) 22:04:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:04:27 INFO - Running setup.py (path:/tmp/pip-urFLCI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:04:27 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)) 22:04:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:04:27 INFO - Running setup.py (path:/tmp/pip-2zPglz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:04:27 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)) 22:04:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:04:27 INFO - Running setup.py (path:/tmp/pip-uco_Zg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:04:27 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)) 22:04:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:04:27 INFO - Running setup.py (path:/tmp/pip-ETUBlG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:04:28 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)) 22:04:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:04:28 INFO - Running setup.py (path:/tmp/pip-mtwzp1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:04:28 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)) 22:04:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:04:28 INFO - Running setup.py (path:/tmp/pip-ggz1RV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:04:28 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)) 22:04:28 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)) 22:04:28 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)) 22:04:28 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)) 22:04:28 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)) 22:04:28 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)) 22:04:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:04:28 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 22:04:28 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 22:04:28 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 22:04:28 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 22:04:28 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 22:04:28 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 22:04:29 INFO - Downloading blessings-1.5.1.tar.gz 22:04:29 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 22:04:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:04:29 INFO - Installing collected packages: blessings 22:04:29 INFO - Running setup.py install for blessings 22:04:30 INFO - Successfully installed blessings 22:04:30 INFO - Cleaning up... 22:04:30 INFO - Return code: 0 22:04:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:04:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:04:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:04:30 INFO - Reading from file tmpfile_stdout 22:04:30 INFO - Current package versions: 22:04:30 INFO - argparse == 1.2.1 22:04:30 INFO - blessings == 1.5.1 22:04:30 INFO - blobuploader == 1.2.4 22:04:30 INFO - docopt == 0.6.1 22:04:30 INFO - manifestparser == 1.1 22:04:30 INFO - mozInstall == 1.12 22:04:30 INFO - mozcrash == 0.16 22:04:30 INFO - mozdebug == 0.1 22:04:30 INFO - mozdevice == 0.47 22:04:30 INFO - mozfile == 1.2 22:04:30 INFO - mozhttpd == 0.7 22:04:30 INFO - mozinfo == 0.9 22:04:30 INFO - mozleak == 0.1 22:04:30 INFO - mozlog == 3.0 22:04:30 INFO - moznetwork == 0.27 22:04:30 INFO - mozprocess == 0.22 22:04:30 INFO - mozprofile == 0.27 22:04:30 INFO - mozrunner == 6.11 22:04:30 INFO - mozscreenshot == 0.1 22:04:30 INFO - mozsystemmonitor == 0.0 22:04:30 INFO - moztest == 0.7 22:04:30 INFO - mozversion == 1.4 22:04:30 INFO - psutil == 3.1.1 22:04:30 INFO - requests == 1.2.3 22:04:30 INFO - wsgiref == 0.1.2 22:04:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:04:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:04:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:04:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:30 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 0x7f1486ce6c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f16c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18a2900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e8b70>, '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 0x1939dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x193a250>, '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': '6e558709db315bacd2260379000001b6-1447997902.82259-879392377', '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 22:04:30 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 22:04:30 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 22:04:30 INFO - Using env: {'DISPLAY': ':0', 22:04:30 INFO - 'HOME': '/home/cltbld', 22:04:30 INFO - 'LANG': 'en_US.UTF-8', 22:04:30 INFO - 'LANGUAGE': 'en_US:en', 22:04:30 INFO - 'LOGNAME': 'cltbld', 22:04:30 INFO - 'MAIL': '/var/mail/cltbld', 22:04:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:04:30 INFO - 'MOZ_NO_REMOTE': '1', 22:04:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:04:30 INFO - 'NO_EM_RESTART': '1', 22:04:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:04:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:04:30 INFO - 'PWD': '/builds/slave/test', 22:04:30 INFO - 'SHELL': '/bin/bash', 22:04:30 INFO - 'SHLVL': '1', 22:04:30 INFO - 'TERM': 'linux', 22:04:30 INFO - 'TMOUT': '86400', 22:04:30 INFO - 'USER': 'cltbld', 22:04:30 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1447997902.82259-879392377', 22:04:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:04:30 INFO - '_': '/tools/buildbot/bin/python'} 22:04:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:04:30 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)) 22:04:30 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)) 22:04:30 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)) 22:04:30 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)) 22:04:30 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)) 22:04:30 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)) 22:04:30 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)) 22:04:30 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)) 22:04:30 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)) 22:04:30 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)) 22:04:30 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)) 22:04:30 INFO - Cleaning up... 22:04:30 INFO - Return code: 0 22:04:30 INFO - Running post-action listener: _resource_record_post_action 22:04:30 INFO - Running post-action listener: _start_resource_monitoring 22:04:30 INFO - Starting resource monitoring. 22:04:30 INFO - ##### 22:04:30 INFO - ##### Running install step. 22:04:30 INFO - ##### 22:04:30 INFO - Running pre-action listener: _resource_record_pre_action 22:04:30 INFO - Running main action method: install 22:04:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:04:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:04:30 INFO - Reading from file tmpfile_stdout 22:04:30 INFO - Detecting whether we're running mozinstall >=1.0... 22:04:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:04:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:04:30 INFO - Reading from file tmpfile_stdout 22:04:30 INFO - Output received: 22:04:30 INFO - Usage: mozinstall [options] installer 22:04:30 INFO - Options: 22:04:30 INFO - -h, --help show this help message and exit 22:04:30 INFO - -d DEST, --destination=DEST 22:04:30 INFO - Directory to install application into. [default: 22:04:30 INFO - "/builds/slave/test"] 22:04:30 INFO - --app=APP Application being installed. [default: firefox] 22:04:30 INFO - mkdir: /builds/slave/test/build/application 22:04:30 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'] 22:04:30 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 22:04:44 INFO - Reading from file tmpfile_stdout 22:04:44 INFO - Output received: 22:04:44 INFO - /builds/slave/test/build/application/firefox/firefox 22:04:44 INFO - Running post-action listener: _resource_record_post_action 22:04:44 INFO - ##### 22:04:44 INFO - ##### Running run-tests step. 22:04:44 INFO - ##### 22:04:44 INFO - Running pre-action listener: _resource_record_pre_action 22:04:44 INFO - Running main action method: run_tests 22:04:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:04:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:04:44 INFO - Python 2.7.3 22:04:44 INFO - Return code: 0 22:04:44 INFO - grabbing minidump binary from tooltool 22:04:44 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')]} 22:04:44 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 0x18e8b70>, '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 0x1939dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x193a250>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:04:44 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 22:04:44 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 22:04:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:04:45 INFO - Return code: 0 22:04:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:04:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:04:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:04:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:04:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:04:45 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/8lMdDzBPRgevcJGbcutB5A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost'] in /builds/slave/test/build 22:04:45 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/8lMdDzBPRgevcJGbcutB5A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --webServer localhost 22:04:45 INFO - Using env: {'DISPLAY': ':0', 22:04:45 INFO - 'HOME': '/home/cltbld', 22:04:45 INFO - 'LANG': 'en_US.UTF-8', 22:04:45 INFO - 'LANGUAGE': 'en_US:en', 22:04:45 INFO - 'LOGNAME': 'cltbld', 22:04:45 INFO - 'MAIL': '/var/mail/cltbld', 22:04:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:04:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:04:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:04:45 INFO - 'MOZ_NO_REMOTE': '1', 22:04:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:04:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:04:45 INFO - 'NO_EM_RESTART': '1', 22:04:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:04:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:04:45 INFO - 'PWD': '/builds/slave/test', 22:04:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:04:45 INFO - 'SHELL': '/bin/bash', 22:04:45 INFO - 'SHLVL': '1', 22:04:45 INFO - 'TERM': 'linux', 22:04:45 INFO - 'TMOUT': '86400', 22:04:45 INFO - 'USER': 'cltbld', 22:04:45 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1447997902.82259-879392377', 22:04:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:04:45 INFO - '_': '/tools/buildbot/bin/python'} 22:04:45 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/8lMdDzBPRgevcJGbcutB5A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost'] with output_timeout 3600 22:04:45 INFO - mozversion INFO | application_buildid: 20151119205634 22:04:45 INFO - mozversion INFO | application_changeset: 3835b568092ae3b71adc931d24928670ad7141a7 22:04:45 INFO - mozversion INFO | application_display_name: Nightly 22:04:45 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:04:45 INFO - mozversion INFO | application_name: Firefox 22:04:45 INFO - mozversion INFO | application_remotingname: firefox 22:04:45 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 22:04:45 INFO - mozversion INFO | application_vendor: Mozilla 22:04:45 INFO - mozversion INFO | application_version: 45.0a1 22:04:45 INFO - mozversion INFO | platform_buildid: 20151119205634 22:04:45 INFO - mozversion INFO | platform_changeset: 3835b568092ae3b71adc931d24928670ad7141a7 22:04:45 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 22:04:45 INFO - mozversion INFO | platform_version: 45.0a1 22:04:45 INFO - 2015-11-19 22:04:45,223 DEBUG : using testdate: 1447999485 22:04:45 INFO - 2015-11-19 22:04:45,223 DEBUG : actual date: 1447999485 22:04:45 INFO - 2015-11-19 22:04:45,236 INFO : starting webserver on 'localhost:56039' 22:04:45 INFO - 2015-11-19 22:04:45,236 INFO : Starting test suite talos-linux64-ix-039.e 22:04:45 INFO - 2015-11-19 22:04:45,236 INFO : Starting test dromaeo_css 22:04:45 INFO - 2015-11-19 22:04:45,236 DEBUG : operating with platform_type : linux_ 22:04:45 INFO - 2015-11-19 22:04:45,237 INFO : Initialising browser for dromaeo_css test... 22:04:45 INFO - 2015-11-19 22:04:45,244 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp91xWKN/profile http://localhost:56039/getInfo.html 22:04:51 INFO - 2015-11-19 22:04:51,703 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:04:51 INFO - 2015-11-19 22:04:51,703 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:04:51 INFO - 2015-11-19 22:04:51,703 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:04:51 INFO - 2015-11-19 22:04:51,703 DEBUG : BROWSER_OUTPUT: __metrics 22:04:52 INFO - 2015-11-19 22:04:52,802 INFO : Browser initialized. 22:04:52 INFO - 2015-11-19 22:04:52,803 INFO : Running cycle 1/1 for dromaeo_css test... 22:04:52 INFO - 2015-11-19 22:04:52,803 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp91xWKN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:05:04 INFO - 2015-11-19 22:05:04,744 DEBUG : BROWSER_OUTPUT: RSS: Main: 141185024 22:05:04 INFO - 2015-11-19 22:05:04,744 DEBUG : BROWSER_OUTPUT: 22:05:54 INFO - 2015-11-19 22:05:54,419 DEBUG : BROWSER_OUTPUT: 1447999554416 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] 22:08:06 INFO - 2015-11-19 22:08:06,455 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56039/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56039/tests/dromaeo/cssquery-ext.html) 22:08:07 INFO - 2015-11-19 22:08:07,661 DEBUG : BROWSER_OUTPUT: RSS: Main: 145178624 22:08:07 INFO - 2015-11-19 22:08:07,661 DEBUG : BROWSER_OUTPUT: 22:11:09 INFO - 2015-11-19 22:11:09,759 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56039/tests/dromaeo/cssquery-ext.html (next: http://localhost:56039/tests/dromaeo/cssquery-jquery.html) 22:11:10 INFO - 2015-11-19 22:11:10,346 DEBUG : BROWSER_OUTPUT: RSS: Main: 140484608 22:11:10 INFO - 2015-11-19 22:11:10,346 DEBUG : BROWSER_OUTPUT: 22:14:12 INFO - 2015-11-19 22:14:12,158 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56039/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56039/tests/dromaeo/cssquery-mootools.html) 22:14:12 INFO - 2015-11-19 22:14:12,744 DEBUG : BROWSER_OUTPUT: RSS: Main: 141946880 22:14:12 INFO - 2015-11-19 22:14:12,744 DEBUG : BROWSER_OUTPUT: 22:17:14 INFO - 2015-11-19 22:17:14,469 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56039/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56039/tests/dromaeo/cssquery-prototype.html) 22:17:15 INFO - 2015-11-19 22:17:15,071 DEBUG : BROWSER_OUTPUT: RSS: Main: 140972032 22:17:15 INFO - 2015-11-19 22:17:15,071 DEBUG : BROWSER_OUTPUT: 22:20:17 INFO - 2015-11-19 22:20:17,681 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56039/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56039/tests/dromaeo/cssquery-yui.html) 22:20:18 INFO - 2015-11-19 22:20:18,311 DEBUG : BROWSER_OUTPUT: RSS: Main: 141123584 22:20:18 INFO - 2015-11-19 22:20:18,311 DEBUG : BROWSER_OUTPUT: 22:23:20 INFO - 2015-11-19 22:23:20,586 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56039/tests/dromaeo/cssquery-yui.html (next: http://localhost:56039/tests/dromaeo/cssquery-dojo.html) 22:23:20 INFO - 2015-11-19 22:23:20,845 DEBUG : BROWSER_OUTPUT: RSS: Main: 144547840 22:23:20 INFO - 2015-11-19 22:23:20,845 DEBUG : BROWSER_OUTPUT: 22:23:20 INFO - 2015-11-19 22:23:20,845 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:23:20 INFO - 2015-11-19 22:23:20,845 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:23:20 INFO - 2015-11-19 22:23:20,845 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:23:20 INFO - 2015-11-19 22:23:20,845 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:23:20 INFO - 2015-11-19 22:23:20,846 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2721.5645496720526;2750.724927507251;2787.163850844746;2793.8463384513857;2810.6205662235607;4702.083093796702;4799.904001919959;4802.951970480294;4836.516348365161;4847.709137451755;4793.90412191756;4806.255030470274;4829.444613869406;4902.803887844482;4912.606991440685;4466.464024317086;4485.910281794362;4522.45730512339;4523.751193684346;4546.318052292149;4486.484054333744;4490.1019796040755;4531.207038768219;4555.271156614942;4556.589906908378;4304.440422745054;4341.522432532419;4410.823567057314;4454.510003899569;4461.107778444324;4441.067375851075;4521.751303678297;4524.864254072383;4529.660275479352;4537.3647689323525;4289.571042895716;4494.348319493655;4503.234450143484;4506.864794056183;4509.954900451019;4550.135474259913;4604.470485894131;4812.037592481518;4827.710337379768;4837.443693975168;5198.428172900978;5198.636095473318;5204.739763011834;5229.529342359206;5278.155495120763;5008.398992120932;5139.203423469368;5241.397239317489;5251.947480525184;5261.631685781997;4738.4313882334;4787.473377928425;4816.060868130681;4825.227963525819;4860.878478038077;5310.9734451327495;5352.732363381893;5363.597730170175;5363.678179309254;5404.8108316208745;4800.903981920412;4892.437369702458;4913.31213630092;5142.1772516397195;5161.870953226125;5011.223260394645;5058.4435712071645;5146.099432599281;5266.526012658879;5323.946760532423;5193.584513238932;5205.583553315726;5207.0366982108435;5219.269302297681;5219.686818790885;4886.193778026586;5165.560927321145;5166.276721259027;5168.689878607295;5206.088934436534;4205.537390887;4252.4046633471335;4293.098449325614;4293.248681480728;4325.718828276152;3775.754575952554;3797;3798.411246256779;3817.1602247505502;3830.4637350770913;4226.070264541858;4334;4433;4493.573110554492;4529.09418116378;5179.896402071938;5290.206469029599;5295.814646487432;5303.973480132652;5330.387005494418;4404.823807047746;4459.888502787457;4461.665375096881;4473.105378924163;4503.639708823286;4310.43964284641;4427.933580996288;4468.106378724268;4610.561996610384;4639.628829693616;4890.315355850255;4910.484399138039;4921.8523444296725;4924.926126108111;4964.180910149785;5182.300389447376;5182.32629758129;5188;5199.55803756685;5247.58019358458;4780.4741478436645;4910.06708725341;4912.435069966999;4917.532834380728;4943.505649435027;5018.623603229699;5101.51535604117;5150.562202212854;5150.716710580954;5183.714895680774;5219.712915789668;5226.97386513065;5231.450697676689;5241.030409374278;5271.71005594696;4739.123262196505;4876.561109500162;5048.621353398436;5058.418281897481;5063.746812659426;4923.286123511999;4999.950000500094;5001.4998500149695;5007.023630392038;5054.823081192288;4869.926951095807;4889.095517329305;4912.042151780369;4948.826791062295;4962.33008543842;4883.560479556857;4994.925076123934;5044.470330615232;5044.697318160922;5046.268291097696;4920.92618610714;4936.901261974668;4974.850754477371;4995.675281106716;5003.974980125076 22:23:20 INFO - 2015-11-19 22:23:20,846 DEBUG : BROWSER_OUTPUT: |1;ext.html;571.6113043130674;577.7573419163954;580.1037397221293;581.4650521520201;590.2091197794954;34243.657563424356;35195.1201219969;35226.64773352269;35251.2949741005;35340.64659353406;39072.80463597685;39435.21129577407;39556.604433955654;39586.40620390696;39702.205955880934;7860.410469214818;7959.880601790977;7996.840063198732;8005.039395272575;8005.959970200141;7860.606969651523;7914.722984695537;7940.086890007666;7953.801154971143;7964.681412743484;7882.330001949813;7928.563928983904;7936.4047696423;7961.960190199041;7977.321927636158;7828.138904720477;7901.20987901211;7912.525248485081;7913.169117242722;7927.484713493604;7742;7884.645190966363;7920;7921.049474063092;7953.920460795376;36228.45657315142;36299.274014519826;36709.632903671154;36734.44898326527;36739.63260367389;2945.513990191616;3018.154916623349;3023.8941637042817;3065;3078.7844850860447;27181.592276115873;27230.727692723016;27468;27497.587536186973;27956.301092472648;3249.4313495138495;3276.5904261967253;3278.1149089745873;3304.653011433789;3336.3660904428325;214031;214102;214295;214566;214639;49936.75031624819;51233.48766512362;51872.481275186765;51893.74053129786;53390.19914701283;50320.24519632208;50338.74830625823;50576.24135637969;50758;50883.236751448756;14079.85920140806;14285.78571321431;14347.354369053417;14361;14363.21002344881;10497.265191436527;10545.367277963192;10577.894221057692;10617.522211500502;10636.627718029831;17251.223694933757;18069.186886590134;18104.456866294033;18239.08804559793;18279.177437015365;6885.51801373899;7072.398846098036;7072.398846098139;7179.89230161548;7294.343509084208;821.8150916043962;876.7764220123828;889.5463313710054;919.9264058875408;931.0642803981955;25657.8717106417;26089.347766305615;26324.868375658;26479.33801654974;26553.33616659599;956.9521523923776;961.3606951377395;962.5427921737258;978;1014.0771897573173;12446.815392807324;12521.311327876872;12733.68165795844;12941.54704585335;12986.155899866479;261821;266513;266855;266882;267059;44286.778566106965;44412.3338149928;44653;44990.32514512285;45029.32456013162;1202.212550779241;1207.444575495282;1225.2893321873114;1247.2267194339386;1266.7149891274573;24400.26799196027;24746.752532474446;24887.87556062208;24888.37779055538;24956.126535571893;39666.40500392554;39946.800265998485;39975.600243997185;40084.1983160341;40119.3982090263;244627;246294;246612;247402;247471;27902.581461278503;29038.564421534116;29571.112866614036;29647.555286670286;29745.10764677063;34465.13837154091;35446.64553354433;38287.42568861414;38739.225215496095;38850.4172437408;32195;32695.50956735603;32905.835470822494;33242;33521.83239083789;31410.52884206693;33045.33909321752;33300.16749581183;33560.49659255162;33763.662363377036;30708.232294192825;30976.84511577428;30980.845095774377;32491.675083248865;33122.66877331292;26955.191344259703;28220.85889570539;29743.256418588844;30899;31144.844275779382;23323.53352932966;23732;23837.523249534566;23979.400514987265;23980.64029039531 22:23:20 INFO - 2015-11-19 22:23:20,846 DEBUG : BROWSER_OUTPUT: |2;jquery.html;325.17081442322086;326.75656635806325;341.8307937570903;341.9692227699507;343.59970634211146;15054.698906021873;15376.769348459782;15799.92100039501;15827.287772050271;16272.349106035774;14625.268736563183;14656.926715366408;14667.706645867076;14692.338844751985;14929.552113436614;4478.820847166117;4592.70147440417;4597.632189424855;4598.264277715566;4601.6548758843055;4726.0784147091335;4739.289106634015;4742.786574604151;4750.928736068944;4755.144074066667;3268.509723541476;3398.4562470004803;4755.072760811643;4813.446453657822;5131.435542090367;5226.451222621608;5297.099493086184;5306.257124002643;5308.70802105884;5339.22581225722;5010.824621138279;5098.872528186788;5118.38579370478;5140.460251673595;5158.948410515922;11338.773224535464;11634.592789252336;11654.359010254433;12724.872751272462;17784.46646600604;1790.4270633397318;1806.2594336322177;1807.8282563156479;1820.553964278747;1865.3937470322064;9011.864822027675;9158.58786354609;9340.813183736354;12360.75278494425;12596.370181490889;1696.762453256545;1813.6916724156792;1866.318793640325;1891.4042076745918;2020.6968954656918;54575.45424545783;55126;55503.889922201735;55978.44021559773;56373.15440268399;9789;9886.209103271722;10077.193824494023;10092.596296148218;10125.848112278321;12591.937040314922;12594.24434533931;12595.181313214613;12597.559085432149;12605.87394126047;7388.889166662504;7468.10382754073;7553.848923021509;7570.962145189239;7600.8479830403085;6854.246032936373;6935.861282774316;7124.750633727795;7174.748883789042;7193.2447093055525;4283.87148385549;4309.633681137138;4312.870613881589;4337.0892112656065;4357.1939191249085;1742.6514697060638;1750.264888746704;1784.634149999247;1789.1769785898373;1823.179569193868;391.2605176216952;395.1129713792554;412.62245045783374;811.8213992921548;820.8932838731046;9332.90667093334;9594.088561586637;9650.276229282692;9826.213902887752;9833.852492212622;406.5852830113327;407.1185882564215;420.38413723894644;428.4237700293101;434.17723414130046;5322.2548843161985;5514.310711161105;5618.157276408489;5635.830925072254;5639.295088113986;472434;478996;479337;482482;487911;69305;71044.64477677578;71972;73287.2671273291;75797.24202757902;1062.9946850265699;1109.1293334732197;1111.572044762772;1113.0761467981556;1115.9051480624237;13928.373223204777;14008;14717.675409212794;14782.63043423923;15119.848801511844;30070.248243793205;30227.58179345691;30488.84755576208;31229.68770312268;31229.843850780602;38105.80947095247;38841.223175535764;39575.60424395719;39845.40231896466;41262.79368603138;8371.33029357662;8543.273821724973;8752.606132723915;9026.86459703118;9050.818983620422;14866.628334291296;15568.29942652606;15636;15732.606684832514;16377.344906204095;12930.288834113837;13948.58154255374;13974.231417272147;14174.787378189129;14447.638809029439;12875;13176.934115329363;13220.933895330461;13394.732105357643;13571.117877337942;13671.931640341734;13833.86166138366;14147.858521414653;14349.856501434851;14593.270336483345;8324.750257492286;8460.857784199301;9020.00779914222;9109.498977556033;9138.406003609743;13410.932945335211;13501.392437340146;13770.31148442594;13803;13860.306984650928 22:23:20 INFO - 2015-11-19 22:23:20,847 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1402.817633707618;1412.1456518806121;1540.6456515001548;1749.1429199692147;1758.8241175882406;6219.657918814475;6299.811005669826;7085.468589855762;7537.246275372453;7561.319481246694;7041.119860017498;7235.855282894339;7259.382952449035;7265.055542779432;7284.708611655527;2131.744190697115;2163.102312540294;2163.4375062483787;2165.967510487344;2167.425632207466;2100.2334148035934;2165.2421652421685;2173.3045425463856;2176.064292354287;2187.639039558471;2042.6425375559293;2047.0992763184227;2063.576966721826;2069.813716765491;2086.238522939124;2105.95788084239;2120.8197303229244;2128.946776330589;2129.6379615465407;2133.9359819205292;2101.2750601042617;2179.8801065941366;2182.4980254541542;2184.2791878679996;2184.9563008739897;7419.962900185518;7502.249775022454;7524.435667324972;7536;7548.131964824061;4311.1808756336195;4354.847580334705;4389.100234451929;4391.824327026915;4401.317795741633;2946.720061594145;2981.403719256136;3069.877204911801;3082.9537556936666;3087.3979573983083;938.4275591888942;967.9516024198762;970.7330484116853;971.825071487132;999.2305924438215;10060.094591486728;10073.143782778472;10101.989801019912;10103.444310562916;10136.13842823361;4026.5570787213383;4121.010957370209;4199.958000420018;4207.642350400189;4216.409702641633;8565.57172141403;8640.697575584825;8642.740717778477;8646.827063458695;8647.870281945776;4481.5070342262325;4485.192665320274;4506.887327816765;4515.525869783691;4523.773811309421;3940.054386947112;4034.2536630722825;4057.959420405817;4064.6545043671026;4066.1257829566784;3289.5723555937575;3309.305045940331;3313.6355000949875;3321.9169520762175;3354.714849237842;1003.2575893838653;1009.0817356205818;1010.2625083688948;1013.1034034879037;1022.3405903192399;1114.8773634900153;1121.9439028048564;1136.0400461609927;1138.459231864874;1216.750566133958;7086;7087.114110736158;7088.574685518885;7092.219855815856;7097.964510177416;448.16417381583113;451.96836221464184;454.52502135268725;457.8511983605275;471.37307381182944;5108.744562771846;5153.45888681683;5153.510416510426;5176.456472070454;5183.196604526304;8470.915290847135;8640.222379985831;8681.2186903179;8770.736877893672;8840.204381605687;8698;8705.260052895448;8707.6516939323;8782.956085219661;8787.34094942869;6710.060591517192;6746.865062698718;6795.014722865157;6861.416779573692;6870.862582748317;6909.481788865754;6920.892657175029;6954.3045695430055;6973.755918542826;6975.476839236976;7741.380689544711;7813.179616140451;7858.292753652198;7913.44605877583;7923.762287131395;8011.959940200261;8013.63938622775;8107.513549187068;8129.715459958873;8137.389695772959;5578.191162281365;6075.3317135115985;6376.458001069961;6413.0701048348665;6445.0332450132855;6851.109355783717;6863.313668633096;6903.896441553481;6914.792556223321;6949.131358580177;6134.723937422737;6228.844278893064;6438.967805161132;6453.09656648079;6556.967215163893;6356.9046464304;6442.323556026549;6520.152380190545;6552.017197420425;6584.736610535525;6588.571742836892;6604.273529911802;6617.139771829631;6646.03632473279;6656.600603963778;6001.939980600313;6028.3971602839365;6041.546883983631;6068.575199736153;6186.412290832363;6199.3490683477585;6279.026750853625;6288.937110629018;6299.307076221704;6301.306856245717 22:23:20 INFO - 2015-11-19 22:23:20,851 DEBUG : BROWSER_OUTPUT: |4;prototype.html;310.88808029109515;315.161669957912;315.8562853901474;318.4284209843331;321.7635038246889;5534.916976245355;5586.966411213928;5679.801206957757;5718.914216286759;5725.856853578663;5590.888182236353;5621.522170615503;5649.971750141254;5652.152177173426;5665.433456654332;4238.830446782125;4344.522102568731;4346.391505189276;4353.10761293934;4353.194658988089;4330.631896288819;4337.262665346882;4342.67429942754;4352.39066530686;4358.498772641139;4290.120525292323;4306.224879521685;4307.117041006586;4312.22379971605;4313.072689371785;4281.6360609348085;4285.378620100084;4292.763897985609;4308.892277693051;4320.654347652212;3657.6342365763476;3762.3980163174033;3762.5484941806885;3768.6419790119894;3769.7549659272336;5296.708681022542;5402.513773760341;5403.162509810985;5405.054115529806;5423.566114710814;4887.193613053842;4897.3878265216845;4913.803447862081;4930.03864246472;4934.087193869145;5888.97055514724;5909.497692696126;5910.08393698973;5910.468057874812;5914.053751399799;3883.8834834954996;4024.315866302706;4027.35562310029;4034.8184331705143;4079.2453396121814;6146.969265153691;6186.288576813679;6197.225346831646;6230.283517395467;6247.375262473762;4115.9588404116175;4116.382542618571;4119.320312148462;4120.979395103005;4127.9174416512105;4177.394277829698;4178.477690288714;4180.143070670505;4183.330667093251;4186.5604111568455;4766.1659209638865;4851.248056551241;4858.878528036827;4883.487233840467;4890.926636100461;5917.230760001258;5921.496672782776;5933.495652869555;5934.554908381889;5943.673097979653;1501.0768377447791;1515.6210947263185;1518.1043184521186;1519.620094976256;1520.2550750132355;961.8653388525612;974.5078735238659;976.8534719791946;994.9154321882577;1008.7629407089328;5067.189249720101;5098;5113.667611605234;5114.948850511447;5130.7947682093045;6127.938720612737;6141.170941922873;6146.446819786241;6148.661823599745;6151.446369826737;5081.339425874687;5089.287499750038;5096.694198348111;5099.97450012755;5101.704233095122;3229.4832826747606;3291.687289707474;3323.7839540430277;3327.667233276653;3329.8168600727195;5656.4060773619;5766.855828604318;5800.53595712342;5807.390224026416;5826.155207494974;6340.841478963062;6355.0785136155;6372.745090196433;6389.648569328731;6391.169148010822;5830.970845145747;5838.416158384128;5849.415058494202;5856.209411729447;5868.061110222344;5976.223090998143;6125.448709616156;6175.505959523317;6179.443850053337;6195;6023.247094113236;6053.788117416046;6054.90917636227;6057.242844644419;6084.178635884099;5785.56608254391;5804.042333015005;5815.621984570989;5817.709114544171;5855.473007429352;4176.686748493936;4225.915481690287;4227.239096962577;4235.237657221606;4244.72409293395;6014.0678194879865;6117.908231376622;6150.815475535741;6155.984262596621;6172.197614310111;5893.941060589339;5912.645241285537;5914.792982245601;5930.775959015369;5930.881382372415;5889.499392551681;5891.38140495259;5919.4968427684125;5932.872754176693;5943.227380440515;5576.86057848557;5763.596548241583;5798.652080875161;5799.478046975623;5803.419658034331;5957.642541447527;5979.372165922689;5984.431479009487;5989.490893273946;5991.910121348271;5788.9449245517235;5805.622634528742;5809.767609295581;5810;5826.533877289891 22:23:20 INFO - 2015-11-19 22:23:20,852 DEBUG : BROWSER_OUTPUT: |5;yui.html;745.3217572009469;766.3256334425705;768.3660979691754;780.0989856715496;811.0429692962302;11515.712107197323;11875.34685592292;11893.167478276524;11925.701857453569;11975.64073077808;11192.38441885696;11208.271462354962;11289.661310160709;11292.153088518353;11309.886901130987;771.4985259581275;789.0964845252183;792.3067316098413;792.6036981509245;794.4081659163902;792.8057625881667;798.4410912361341;798.5129071266523;800.3677095094897;801.1347744436024;820.446198815797;823.8846561481397;827.3794654009492;830.8006078541167;831.2767891934026;825.4964471672275;826.2687521543418;828.995855020727;832.076395201326;832.6419639554989;611.7124951272939;612.1368869893429;612.5099920063975;613.2365205319406;614.9538784591128;12705.682357941034;12739.808902866464;12766.680832979157;12806.871931280753;12850.100492965496;10951.561937522489;11244.831327530093;11414.201005929588;11453.59912403062;11908.16642835002;8967.058458861857;9000.279977601776;9185.311101667401;9264.72205833826;9485.762855928588;3037.9848100759355;3126.3434678717495;3141.8429078545983;3142.1673256587023;3151.9684803151904;37577.81211093954;38121;38320.80839595812;38404.80797596022;38417.61582384168;9150.771230719152;9273.397229180082;9437.103475169848;9665.081817227352;9669.806603867883;16484.587885302724;16512.33950641985;16517.174141292886;16519.33922643081;16546.751798723028;6307.747690092437;6337.271213810471;6448.484121270287;6500.70746816385;6546.312637173123;3444.0528854565196;3448.9827550862087;3486.8082255475683;3515.209077957439;3546.7517273791104;2738.904138355188;2748.175547335791;2769.736874996872;2770.4736100141313;2778.8610569471443;474.4591166070682;478.12980375715864;478.19424270104986;482.879280179955;483.14242220058975;573.9626924249994;574.1072632057192;580.5877826742975;597.6145386225946;628.3527966194827;7150.606716630636;7250.4199664026755;7380.114386273574;7601.923980760122;7616.35261002821;497.49255759125487;570.224494687225;584.5119325363285;600.1447936690199;604.1511676095093;3325.201951531615;3523.5947865995226;3532;3588.4976103345552;3601.441776524643;50347;50995;51121;51168;51998;38301.80849095793;44329.335059974124;48958.26562601564;49726.50273497291;49988;36616.45075323872;40672.38991415072;40782.388264176065;41212.58787412087;41396.1720765583;7450.329470347695;7786;8003.83992320162;8033.839323213386;8238.299744521542;32418.189545261557;32507.512387313735;32600.413954465464;32746.181345466553;33588;37006.44490332593;37097.629023709414;39999.60000400075;40173.19653606853;42523;9380.34337596389;9550.474723890253;9560.187384072431;9803.411795292306;10081.747956301151;10639.255252132276;10735.570577177137;11310.660680179608;11551.133664974992;11614.76770464569;10389.688309350731;10630.52162652698;10656.62701805433;10742.3017503862;10967.067799236835;10946.17903657213;11102.944485277521;11130.777384452427;11152.944235278772;11194.160437967348;10132.848007279748;10439.289362868643;10471.10995565355;10513.211509136692;10773.784524309312;9488.810223795348;9496.810063798546;9609.567569459252;9979.301448898508;10017.69946901594;9311.686435485259;9510.1440870322;9517.23862091045;9601.759956001157;9607.292077453274 22:23:20 INFO - 2015-11-19 22:23:20,852 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:23:20 INFO - 2015-11-19 22:23:20,852 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:23:20 INFO - 2015-11-19 22:23:20,852 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,307 22:23:20 INFO - 2015-11-19 22:23:20,852 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:23:20 INFO - 2015-11-19 22:23:20,852 DEBUG : BROWSER_OUTPUT: __startTimestamp1448000600838__endTimestamp 22:23:20 INFO - 2015-11-19 22:23:20,852 DEBUG : BROWSER_OUTPUT: 22:23:20 INFO - 2015-11-19 22:23:20,853 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:23:20 INFO - 2015-11-19 22:23:20,853 DEBUG : BROWSER_OUTPUT: Number of tests: 6 22:23:20 INFO - 2015-11-19 22:23:20,853 DEBUG : BROWSER_OUTPUT: 22:23:20 INFO - 2015-11-19 22:23:20,853 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4773.05 Median:4892.44 stddev:504.26 (10.3%) stddev-sans-first:479.44 22:23:20 INFO - 2015-11-19 22:23:20,853 DEBUG : BROWSER_OUTPUT: Values: 2721.6 2750.7 2787.2 2793.8 2810.6 4702.1 4799.9 4803.0 4836.5 4847.7 4793.9 4806.3 4829.4 4902.8 4912.6 4466.5 4485.9 4522.5 4523.8 4546.3 4486.5 4490.1 4531.2 4555.3 4556.6 4304.4 4341.5 4410.8 4454.5 4461.1 4441.1 4521.8 4524.9 4529.7 4537.4 4289.6 4494.3 4503.2 4506.9 4510.0 4550.1 4604.5 4812.0 4827.7 4837.4 5198.4 5198.6 5204.7 5229.5 5278.2 5008.4 5139.2 5241.4 5251.9 5261.6 4738.4 4787.5 4816.1 4825.2 4860.9 5311.0 5352.7 5363.6 5363.7 5404.8 4800.9 4892.4 4913.3 5142.2 5161.9 5011.2 5058.4 5146.1 5266.5 5323.9 5193.6 5205.6 5207.0 5219.3 5219.7 4886.2 5165.6 5166.3 5168.7 5206.1 4205.5 4252.4 4293.1 4293.2 4325.7 3775.8 3797.0 3798.4 3817.2 3830.5 4226.1 4334.0 4433.0 4493.6 4529.1 5179.9 5290.2 5295.8 5304.0 5330.4 4404.8 4459.9 4461.7 4473.1 4503.6 4310.4 4427.9 4468.1 4610.6 4639.6 4890.3 4910.5 4921.9 4924.9 4964.2 5182.3 5182.3 5188.0 5199.6 5247.6 4780.5 4910.1 4912.4 4917.5 4943.5 5018.6 5101.5 5150.6 5150.7 5183.7 5219.7 5227.0 5231.5 5241.0 5271.7 4739.1 4876.6 5048.6 5058.4 5063.7 4923.3 5000.0 5001.5 5007.0 5054.8 4869.9 4889.1 4912.0 4948.8 4962.3 4883.6 4994.9 5044.5 5044.7 5046.3 4920.9 4936.9 4974.9 4995.7 5004.0 22:23:20 INFO - 2015-11-19 22:23:20,853 DEBUG : BROWSER_OUTPUT: 22:23:20 INFO - 2015-11-19 22:23:20,853 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39788.82 Median:33271.08 stddev:63289.20 (190.2%) stddev-sans-first:63398.24 22:23:20 INFO - 2015-11-19 22:23:20,853 DEBUG : BROWSER_OUTPUT: Values: 571.6 577.8 580.1 581.5 590.2 34243.7 35195.1 35226.6 35251.3 35340.6 39072.8 39435.2 39556.6 39586.4 39702.2 7860.4 7959.9 7996.8 8005.0 8006.0 7860.6 7914.7 7940.1 7953.8 7964.7 7882.3 7928.6 7936.4 7962.0 7977.3 7828.1 7901.2 7912.5 7913.2 7927.5 7742.0 7884.6 7920.0 7921.0 7953.9 36228.5 36299.3 36709.6 36734.4 36739.6 2945.5 3018.2 3023.9 3065.0 3078.8 27181.6 27230.7 27468.0 27497.6 27956.3 3249.4 3276.6 3278.1 3304.7 3336.4 214031.0 214102.0 214295.0 214566.0 214639.0 49936.8 51233.5 51872.5 51893.7 53390.2 50320.2 50338.7 50576.2 50758.0 50883.2 14079.9 14285.8 14347.4 14361.0 14363.2 10497.3 10545.4 10577.9 10617.5 10636.6 17251.2 18069.2 18104.5 18239.1 18279.2 6885.5 7072.4 7072.4 7179.9 7294.3 821.8 876.8 889.5 919.9 931.1 25657.9 26089.3 26324.9 26479.3 26553.3 957.0 961.4 962.5 978.0 1014.1 12446.8 12521.3 12733.7 12941.5 12986.2 261821.0 266513.0 266855.0 266882.0 267059.0 44286.8 44412.3 44653.0 44990.3 45029.3 1202.2 1207.4 1225.3 1247.2 1266.7 24400.3 24746.8 24887.9 24888.4 24956.1 39666.4 39946.8 39975.6 40084.2 40119.4 244627.0 246294.0 246612.0 247402.0 247471.0 27902.6 29038.6 29571.1 29647.6 29745.1 34465.1 35446.6 38287.4 38739.2 38850.4 32195.0 32695.5 32905.8 33242.0 33521.8 31410.5 33045.3 33300.2 33560.5 33763.7 30708.2 30976.8 30980.8 32491.7 33122.7 26955.2 28220.9 29743.3 30899.0 31144.8 23323.5 23732.0 23837.5 23979.4 23980.6 22:23:20 INFO - 2015-11-19 22:23:20,853 DEBUG : BROWSER_OUTPUT: 22:23:20 INFO - 2015-11-19 22:23:20,854 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25646.86 Median:19985.36 stddev:78486.80 (392.7%) stddev-sans-first:78683.94 22:23:20 INFO - 2015-11-19 22:23:20,855 DEBUG : BROWSER_OUTPUT: Values: 325.2 326.8 341.8 342.0 343.6 15054.7 15376.8 15799.9 15827.3 16272.3 14625.3 14656.9 14667.7 14692.3 14929.6 4478.8 4592.7 4597.6 4598.3 4601.7 4726.1 4739.3 4742.8 4750.9 4755.1 3268.5 3398.5 4755.1 4813.4 5131.4 5226.5 5297.1 5306.3 5308.7 5339.2 5010.8 5098.9 5118.4 5140.5 5158.9 11338.8 11634.6 11654.4 12724.9 17784.5 1790.4 1806.3 1807.8 1820.6 1865.4 9011.9 9158.6 9340.8 12360.8 12596.4 1696.8 1813.7 1866.3 1891.4 2020.7 54575.5 55126.0 55503.9 55978.4 56373.2 9789.0 9886.2 10077.2 10092.6 10125.8 12591.9 12594.2 12595.2 12597.6 12605.9 7388.9 7468.1 7553.8 7571.0 7600.8 6854.2 6935.9 7124.8 7174.7 7193.2 4283.9 4309.6 4312.9 4337.1 4357.2 1742.7 1750.3 1784.6 1789.2 1823.2 391.3 395.1 412.6 811.8 820.9 9332.9 9594.1 9650.3 9826.2 9833.9 406.6 407.1 420.4 428.4 434.2 5322.3 5514.3 5618.2 5635.8 5639.3 472434.0 478996.0 479337.0 482482.0 487911.0 69305.0 71044.6 71972.0 73287.3 75797.2 1063.0 1109.1 1111.6 1113.1 1115.9 13928.4 14008.0 14717.7 14782.6 15119.8 30070.2 30227.6 30488.8 31229.7 31229.8 38105.8 38841.2 39575.6 39845.4 41262.8 8371.3 8543.3 8752.6 9026.9 9050.8 14866.6 15568.3 15636.0 15732.6 16377.3 12930.3 13948.6 13974.2 14174.8 14447.6 12875.0 13176.9 13220.9 13394.7 13571.1 13671.9 13833.9 14147.9 14349.9 14593.3 8324.8 8460.9 9020.0 9109.5 9138.4 13410.9 13501.4 13770.3 13803.0 13860.3 22:23:20 INFO - 2015-11-19 22:23:20,855 DEBUG : BROWSER_OUTPUT: 22:23:20 INFO - 2015-11-19 22:23:20,855 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5106.98 Median:6105.03 stddev:2667.23 (43.7%) stddev-sans-first:2660.18 22:23:20 INFO - 2015-11-19 22:23:20,855 DEBUG : BROWSER_OUTPUT: Values: 1402.8 1412.1 1540.6 1749.1 1758.8 6219.7 6299.8 7085.5 7537.2 7561.3 7041.1 7235.9 7259.4 7265.1 7284.7 2131.7 2163.1 2163.4 2166.0 2167.4 2100.2 2165.2 2173.3 2176.1 2187.6 2042.6 2047.1 2063.6 2069.8 2086.2 2106.0 2120.8 2128.9 2129.6 2133.9 2101.3 2179.9 2182.5 2184.3 2185.0 7420.0 7502.2 7524.4 7536.0 7548.1 4311.2 4354.8 4389.1 4391.8 4401.3 2946.7 2981.4 3069.9 3083.0 3087.4 938.4 968.0 970.7 971.8 999.2 10060.1 10073.1 10102.0 10103.4 10136.1 4026.6 4121.0 4200.0 4207.6 4216.4 8565.6 8640.7 8642.7 8646.8 8647.9 4481.5 4485.2 4506.9 4515.5 4523.8 3940.1 4034.3 4058.0 4064.7 4066.1 3289.6 3309.3 3313.6 3321.9 3354.7 1003.3 1009.1 1010.3 1013.1 1022.3 1114.9 1121.9 1136.0 1138.5 1216.8 7086.0 7087.1 7088.6 7092.2 7098.0 448.2 452.0 454.5 457.9 471.4 5108.7 5153.5 5153.5 5176.5 5183.2 8470.9 8640.2 8681.2 8770.7 8840.2 8698.0 8705.3 8707.7 8783.0 8787.3 6710.1 6746.9 6795.0 6861.4 6870.9 6909.5 6920.9 6954.3 6973.8 6975.5 7741.4 7813.2 7858.3 7913.4 7923.8 8012.0 8013.6 8107.5 8129.7 8137.4 5578.2 6075.3 6376.5 6413.1 6445.0 6851.1 6863.3 6903.9 6914.8 6949.1 6134.7 6228.8 6439.0 6453.1 6557.0 6356.9 6442.3 6520.2 6552.0 6584.7 6588.6 6604.3 6617.1 6646.0 6656.6 6001.9 6028.4 6041.5 6068.6 6186.4 6199.3 6279.0 6288.9 6299.3 6301.3 22:23:20 INFO - 2015-11-19 22:23:20,855 DEBUG : BROWSER_OUTPUT: 22:23:20 INFO - 2015-11-19 22:23:20,855 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4887.89 Median:5635.75 stddev:1456.87 (25.9%) stddev-sans-first:1419.88 22:23:20 INFO - 2015-11-19 22:23:20,856 DEBUG : BROWSER_OUTPUT: Values: 310.9 315.2 315.9 318.4 321.8 5534.9 5587.0 5679.8 5718.9 5725.9 5590.9 5621.5 5650.0 5652.2 5665.4 4238.8 4344.5 4346.4 4353.1 4353.2 4330.6 4337.3 4342.7 4352.4 4358.5 4290.1 4306.2 4307.1 4312.2 4313.1 4281.6 4285.4 4292.8 4308.9 4320.7 3657.6 3762.4 3762.5 3768.6 3769.8 5296.7 5402.5 5403.2 5405.1 5423.6 4887.2 4897.4 4913.8 4930.0 4934.1 5889.0 5909.5 5910.1 5910.5 5914.1 3883.9 4024.3 4027.4 4034.8 4079.2 6147.0 6186.3 6197.2 6230.3 6247.4 4116.0 4116.4 4119.3 4121.0 4127.9 4177.4 4178.5 4180.1 4183.3 4186.6 4766.2 4851.2 4858.9 4883.5 4890.9 5917.2 5921.5 5933.5 5934.6 5943.7 1501.1 1515.6 1518.1 1519.6 1520.3 961.9 974.5 976.9 994.9 1008.8 5067.2 5098.0 5113.7 5114.9 5130.8 6127.9 6141.2 6146.4 6148.7 6151.4 5081.3 5089.3 5096.7 5100.0 5101.7 3229.5 3291.7 3323.8 3327.7 3329.8 5656.4 5766.9 5800.5 5807.4 5826.2 6340.8 6355.1 6372.7 6389.6 6391.2 5831.0 5838.4 5849.4 5856.2 5868.1 5976.2 6125.4 6175.5 6179.4 6195.0 6023.2 6053.8 6054.9 6057.2 6084.2 5785.6 5804.0 5815.6 5817.7 5855.5 4176.7 4225.9 4227.2 4235.2 4244.7 6014.1 6117.9 6150.8 6156.0 6172.2 5893.9 5912.6 5914.8 5930.8 5930.9 5889.5 5891.4 5919.5 5932.9 5943.2 5576.9 5763.6 5798.7 5799.5 5803.4 5957.6 5979.4 5984.4 5989.5 5991.9 5788.9 5805.6 5809.8 5810.0 5826.5 22:23:20 INFO - 2015-11-19 22:23:20,856 DEBUG : BROWSER_OUTPUT: 22:23:20 INFO - 2015-11-19 22:23:20,856 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12317.50 Median:478.16 stddev:13956.06 (2918.7%) stddev-sans-first:13968.15 22:23:20 INFO - 2015-11-19 22:23:20,857 DEBUG : BROWSER_OUTPUT: Values: 745.3 766.3 768.4 780.1 811.0 11515.7 11875.3 11893.2 11925.7 11975.6 11192.4 11208.3 11289.7 11292.2 11309.9 771.5 789.1 792.3 792.6 794.4 792.8 798.4 798.5 800.4 801.1 820.4 823.9 827.4 830.8 831.3 825.5 826.3 829.0 832.1 832.6 611.7 612.1 612.5 613.2 615.0 12705.7 12739.8 12766.7 12806.9 12850.1 10951.6 11244.8 11414.2 11453.6 11908.2 8967.1 9000.3 9185.3 9264.7 9485.8 3038.0 3126.3 3141.8 3142.2 3152.0 37577.8 38121.0 38320.8 38404.8 38417.6 9150.8 9273.4 9437.1 9665.1 9669.8 16484.6 16512.3 16517.2 16519.3 16546.8 6307.7 6337.3 6448.5 6500.7 6546.3 3444.1 3449.0 3486.8 3515.2 3546.8 2738.9 2748.2 2769.7 2770.5 2778.9 474.5 478.1 478.2 482.9 483.1 574.0 574.1 580.6 597.6 628.4 7150.6 7250.4 7380.1 7601.9 7616.4 497.5 570.2 584.5 600.1 604.2 3325.2 3523.6 3532.0 3588.5 3601.4 50347.0 50995.0 51121.0 51168.0 51998.0 38301.8 44329.3 48958.3 49726.5 49988.0 36616.5 40672.4 40782.4 41212.6 41396.2 7450.3 7786.0 8003.8 8033.8 8238.3 32418.2 32507.5 32600.4 32746.2 33588.0 37006.4 37097.6 39999.6 40173.2 42523.0 9380.3 9550.5 9560.2 9803.4 10081.7 10639.3 10735.6 11310.7 11551.1 11614.8 10389.7 10630.5 10656.6 10742.3 10967.1 10946.2 11102.9 11130.8 11152.9 11194.2 10132.8 10439.3 10471.1 10513.2 10773.8 9488.8 9496.8 9609.6 9979.3 10017.7 9311.7 9510.1 9517.2 9601.8 9607.3 22:23:20 INFO - 2015-11-19 22:23:20,857 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:23:20 INFO - 2015-11-19 22:23:20,857 DEBUG : BROWSER_OUTPUT: 22:23:21 INFO - 2015-11-19 22:23:21,483 INFO : Browser exited with error code: 0 22:23:21 INFO - 2015-11-19 22:23:21,504 INFO : Completed test dromaeo_css (00:18:36) 22:23:21 INFO - 2015-11-19 22:23:21,504 INFO : Starting test kraken 22:23:21 INFO - 2015-11-19 22:23:21,504 DEBUG : operating with platform_type : linux_ 22:23:21 INFO - 2015-11-19 22:23:21,504 INFO : Initialising browser for kraken test... 22:23:21 INFO - 2015-11-19 22:23:21,510 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp41CdVq/profile http://localhost:56039/getInfo.html 22:23:26 INFO - 2015-11-19 22:23:26,272 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:23:26 INFO - 2015-11-19 22:23:26,272 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:23:26 INFO - 2015-11-19 22:23:26,272 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:23:26 INFO - 2015-11-19 22:23:26,273 DEBUG : BROWSER_OUTPUT: __metrics 22:23:27 INFO - 2015-11-19 22:23:27,418 INFO : Browser initialized. 22:23:27 INFO - 2015-11-19 22:23:27,419 INFO : Running cycle 1/1 for kraken test... 22:23:27 INFO - 2015-11-19 22:23:27,419 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp41CdVq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:23:39 INFO - 2015-11-19 22:23:39,382 DEBUG : BROWSER_OUTPUT: RSS: Main: 141332480 22:23:39 INFO - 2015-11-19 22:23:39,383 DEBUG : BROWSER_OUTPUT: 22:23:41 INFO - 2015-11-19 22:23:41,979 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56039/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56039/tests/kraken/driver.html?testName=audio-beat-detection) 22:23:42 INFO - 2015-11-19 22:23:42,600 DEBUG : BROWSER_OUTPUT: RSS: Main: 140333056 22:23:42 INFO - 2015-11-19 22:23:42,601 DEBUG : BROWSER_OUTPUT: 22:23:45 INFO - 2015-11-19 22:23:45,362 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56039/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56039/tests/kraken/driver.html?testName=audio-dft) 22:23:45 INFO - 2015-11-19 22:23:45,964 DEBUG : BROWSER_OUTPUT: RSS: Main: 140898304 22:23:45 INFO - 2015-11-19 22:23:45,964 DEBUG : BROWSER_OUTPUT: 22:23:48 INFO - 2015-11-19 22:23:48,891 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56039/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56039/tests/kraken/driver.html?testName=audio-fft) 22:23:49 INFO - 2015-11-19 22:23:49,473 DEBUG : BROWSER_OUTPUT: RSS: Main: 137453568 22:23:49 INFO - 2015-11-19 22:23:49,473 DEBUG : BROWSER_OUTPUT: 22:23:51 INFO - 2015-11-19 22:23:51,531 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56039/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56039/tests/kraken/driver.html?testName=audio-oscillator) 22:23:52 INFO - 2015-11-19 22:23:52,153 DEBUG : BROWSER_OUTPUT: RSS: Main: 136548352 22:23:52 INFO - 2015-11-19 22:23:52,153 DEBUG : BROWSER_OUTPUT: 22:23:54 INFO - 2015-11-19 22:23:54,372 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56039/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56039/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:23:54 INFO - 2015-11-19 22:23:54,953 DEBUG : BROWSER_OUTPUT: RSS: Main: 138489856 22:23:54 INFO - 2015-11-19 22:23:54,953 DEBUG : BROWSER_OUTPUT: 22:23:58 INFO - 2015-11-19 22:23:58,055 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56039/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56039/tests/kraken/driver.html?testName=imaging-darkroom) 22:23:58 INFO - 2015-11-19 22:23:58,656 DEBUG : BROWSER_OUTPUT: RSS: Main: 138543104 22:23:58 INFO - 2015-11-19 22:23:58,656 DEBUG : BROWSER_OUTPUT: 22:24:02 INFO - 2015-11-19 22:24:02,165 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56039/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56039/tests/kraken/driver.html?testName=imaging-desaturate) 22:24:02 INFO - 2015-11-19 22:24:02,758 DEBUG : BROWSER_OUTPUT: RSS: Main: 136421376 22:24:02 INFO - 2015-11-19 22:24:02,759 DEBUG : BROWSER_OUTPUT: 22:24:05 INFO - 2015-11-19 22:24:05,645 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56039/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56039/tests/kraken/driver.html?testName=json-parse-financial) 22:24:06 INFO - 2015-11-19 22:24:06,248 DEBUG : BROWSER_OUTPUT: RSS: Main: 137142272 22:24:06 INFO - 2015-11-19 22:24:06,248 DEBUG : BROWSER_OUTPUT: 22:24:08 INFO - 2015-11-19 22:24:08,010 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56039/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56039/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:24:08 INFO - 2015-11-19 22:24:08,596 DEBUG : BROWSER_OUTPUT: RSS: Main: 138928128 22:24:08 INFO - 2015-11-19 22:24:08,596 DEBUG : BROWSER_OUTPUT: 22:24:10 INFO - 2015-11-19 22:24:10,519 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56039/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56039/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:24:11 INFO - 2015-11-19 22:24:11,132 DEBUG : BROWSER_OUTPUT: RSS: Main: 138940416 22:24:11 INFO - 2015-11-19 22:24:11,132 DEBUG : BROWSER_OUTPUT: 22:24:13 INFO - 2015-11-19 22:24:13,284 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56039/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56039/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:24:13 INFO - 2015-11-19 22:24:13,877 DEBUG : BROWSER_OUTPUT: RSS: Main: 139243520 22:24:13 INFO - 2015-11-19 22:24:13,878 DEBUG : BROWSER_OUTPUT: 22:24:16 INFO - 2015-11-19 22:24:16,494 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56039/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56039/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:24:17 INFO - 2015-11-19 22:24:17,096 DEBUG : BROWSER_OUTPUT: RSS: Main: 139812864 22:24:17 INFO - 2015-11-19 22:24:17,096 DEBUG : BROWSER_OUTPUT: 22:24:19 INFO - 2015-11-19 22:24:19,717 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56039/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56039/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:24:20 INFO - 2015-11-19 22:24:20,323 DEBUG : BROWSER_OUTPUT: RSS: Main: 140042240 22:24:20 INFO - 2015-11-19 22:24:20,323 DEBUG : BROWSER_OUTPUT: 22:24:22 INFO - 2015-11-19 22:24:22,101 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56039/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56039/tests/kraken/driver.html?testName=ai-astar) 22:24:22 INFO - 2015-11-19 22:24:22,351 DEBUG : BROWSER_OUTPUT: RSS: Main: 138510336 22:24:22 INFO - 2015-11-19 22:24:22,351 DEBUG : BROWSER_OUTPUT: 22:24:22 INFO - 2015-11-19 22:24:22,354 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:24:22 INFO - 2015-11-19 22:24:22,354 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:24:22 INFO - 2015-11-19 22:24:22,355 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:24:22 INFO - 2015-11-19 22:24:22,355 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:24:22 INFO - 2015-11-19 22:24:22,355 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;107;113;114;112;124;114;112;111;112 22:24:22 INFO - 2015-11-19 22:24:22,355 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;159;130;160;167;133;162;162;132;177;138 22:24:22 INFO - 2015-11-19 22:24:22,355 DEBUG : BROWSER_OUTPUT: |2;audio-dft;165;163;164;165;165;163;168;164;166;163 22:24:22 INFO - 2015-11-19 22:24:22,355 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;75;73;74;73;74;138;72;74;75 22:24:22 INFO - 2015-11-19 22:24:22,355 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;91;126;92;93;91;126;91;91;131 22:24:22 INFO - 2015-11-19 22:24:22,355 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;111;110;113;111;110;111;110;111;110 22:24:22 INFO - 2015-11-19 22:24:22,355 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;149;150;148;147;148;149;149;147;148;149 22:24:22 INFO - 2015-11-19 22:24:22,355 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;96;96;96;96;97;96;96 22:24:22 INFO - 2015-11-19 22:24:22,355 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;71;72;72;73;75;73;72;72;71;70 22:24:22 INFO - 2015-11-19 22:24:22,355 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;70;70;70;70;70;69;69;69 22:24:22 INFO - 2015-11-19 22:24:22,356 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;84;85;86;83;82;92;85;85;84 22:24:22 INFO - 2015-11-19 22:24:22,356 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;133;130;120;124;127;134;127;131;125;129 22:24:22 INFO - 2015-11-19 22:24:22,356 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;147;161;146;158;160;139;152;146;147;146 22:24:22 INFO - 2015-11-19 22:24:22,356 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;72;72;72;73;70;72;69;68;69;69 22:24:22 INFO - 2015-11-19 22:24:22,356 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:24:22 INFO - 2015-11-19 22:24:22,356 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:24:22 INFO - 2015-11-19 22:24:22,356 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,777 22:24:22 INFO - 2015-11-19 22:24:22,357 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:24:22 INFO - 2015-11-19 22:24:22,357 DEBUG : BROWSER_OUTPUT: __startTimestamp1448000662352__endTimestamp 22:24:22 INFO - 2015-11-19 22:24:22,357 DEBUG : BROWSER_OUTPUT: 22:24:22 INFO - 2015-11-19 22:24:22,364 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:24:22 INFO - 2015-11-19 22:24:22,365 DEBUG : BROWSER_OUTPUT: Number of tests: 14 22:24:22 INFO - 2015-11-19 22:24:22,365 DEBUG : BROWSER_OUTPUT: 22:24:22 INFO - 2015-11-19 22:24:22,365 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:113.20 Median:113.00 stddev:4.29 (3.8%) stddev-sans-first:4.55 22:24:22 INFO - 2015-11-19 22:24:22,365 DEBUG : BROWSER_OUTPUT: Values: 113.0 107.0 113.0 114.0 112.0 124.0 114.0 112.0 111.0 112.0 22:24:22 INFO - 2015-11-19 22:24:22,365 DEBUG : BROWSER_OUTPUT: 22:24:22 INFO - 2015-11-19 22:24:22,365 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:152.00 Median:161.00 stddev:17.01 (10.6%) stddev-sans-first:17.85 22:24:22 INFO - 2015-11-19 22:24:22,365 DEBUG : BROWSER_OUTPUT: Values: 159.0 130.0 160.0 167.0 133.0 162.0 162.0 132.0 177.0 138.0 22:24:22 INFO - 2015-11-19 22:24:22,365 DEBUG : BROWSER_OUTPUT: 22:24:22 INFO - 2015-11-19 22:24:22,366 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.60 Median:165.00 stddev:1.58 (1.0%) stddev-sans-first:1.67 22:24:22 INFO - 2015-11-19 22:24:22,366 DEBUG : BROWSER_OUTPUT: Values: 165.0 163.0 164.0 165.0 165.0 163.0 168.0 164.0 166.0 163.0 22:24:22 INFO - 2015-11-19 22:24:22,366 DEBUG : BROWSER_OUTPUT: 22:24:22 INFO - 2015-11-19 22:24:22,366 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.10 Median:74.00 stddev:20.37 (27.5%) stddev-sans-first:21.44 22:24:22 INFO - 2015-11-19 22:24:22,366 DEBUG : BROWSER_OUTPUT: Values: 73.0 75.0 73.0 74.0 73.0 74.0 138.0 72.0 74.0 75.0 22:24:22 INFO - 2015-11-19 22:24:22,366 DEBUG : BROWSER_OUTPUT: 22:24:22 INFO - 2015-11-19 22:24:22,366 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.30 Median:91.00 stddev:17.57 (19.3%) stddev-sans-first:18.15 22:24:22 INFO - 2015-11-19 22:24:22,367 DEBUG : BROWSER_OUTPUT: Values: 91.0 91.0 126.0 92.0 93.0 91.0 126.0 91.0 91.0 131.0 22:24:22 INFO - 2015-11-19 22:24:22,367 DEBUG : BROWSER_OUTPUT: 22:24:22 INFO - 2015-11-19 22:24:22,367 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.70 Median:111.00 stddev:0.95 (0.9%) stddev-sans-first:0.97 22:24:22 INFO - 2015-11-19 22:24:22,367 DEBUG : BROWSER_OUTPUT: Values: 110.0 111.0 110.0 113.0 111.0 110.0 111.0 110.0 111.0 110.0 22:24:22 INFO - 2015-11-19 22:24:22,367 DEBUG : BROWSER_OUTPUT: 22:24:22 INFO - 2015-11-19 22:24:22,367 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.40 Median:149.00 stddev:0.97 (0.6%) stddev-sans-first:1.00 22:24:22 INFO - 2015-11-19 22:24:22,367 DEBUG : BROWSER_OUTPUT: Values: 149.0 150.0 148.0 147.0 148.0 149.0 149.0 147.0 148.0 149.0 22:24:22 INFO - 2015-11-19 22:24:22,367 DEBUG : BROWSER_OUTPUT: 22:24:22 INFO - 2015-11-19 22:24:22,367 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 22:24:22 INFO - 2015-11-19 22:24:22,367 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 96.0 96.0 96.0 96.0 97.0 96.0 96.0 22:24:22 INFO - 2015-11-19 22:24:22,367 DEBUG : BROWSER_OUTPUT: 22:24:22 INFO - 2015-11-19 22:24:22,368 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.10 Median:72.00 stddev:1.37 (1.9%) stddev-sans-first:1.39 22:24:22 INFO - 2015-11-19 22:24:22,368 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 72.0 73.0 75.0 73.0 72.0 72.0 71.0 70.0 22:24:22 INFO - 2015-11-19 22:24:22,368 DEBUG : BROWSER_OUTPUT: 22:24:22 INFO - 2015-11-19 22:24:22,368 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.50 Median:70.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 22:24:22 INFO - 2015-11-19 22:24:22,368 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 70.0 70.0 70.0 70.0 70.0 69.0 69.0 69.0 22:24:22 INFO - 2015-11-19 22:24:22,368 DEBUG : BROWSER_OUTPUT: 22:24:22 INFO - 2015-11-19 22:24:22,368 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:85.00 stddev:2.86 (3.4%) stddev-sans-first:2.85 22:24:22 INFO - 2015-11-19 22:24:22,368 DEBUG : BROWSER_OUTPUT: Values: 82.0 84.0 85.0 86.0 83.0 82.0 92.0 85.0 85.0 84.0 22:24:22 INFO - 2015-11-19 22:24:22,368 DEBUG : BROWSER_OUTPUT: 22:24:22 INFO - 2015-11-19 22:24:22,368 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:128.00 Median:129.50 stddev:4.29 (3.3%) stddev-sans-first:4.16 22:24:22 INFO - 2015-11-19 22:24:22,368 DEBUG : BROWSER_OUTPUT: Values: 133.0 130.0 120.0 124.0 127.0 134.0 127.0 131.0 125.0 129.0 22:24:22 INFO - 2015-11-19 22:24:22,369 DEBUG : BROWSER_OUTPUT: 22:24:22 INFO - 2015-11-19 22:24:22,369 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.20 Median:149.50 stddev:7.27 (4.9%) stddev-sans-first:7.62 22:24:22 INFO - 2015-11-19 22:24:22,369 DEBUG : BROWSER_OUTPUT: Values: 147.0 161.0 146.0 158.0 160.0 139.0 152.0 146.0 147.0 146.0 22:24:22 INFO - 2015-11-19 22:24:22,369 DEBUG : BROWSER_OUTPUT: 22:24:22 INFO - 2015-11-19 22:24:22,369 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.60 Median:72.00 stddev:1.78 (2.5%) stddev-sans-first:1.81 22:24:22 INFO - 2015-11-19 22:24:22,369 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 72.0 73.0 70.0 72.0 69.0 68.0 69.0 69.0 22:24:22 INFO - 2015-11-19 22:24:22,369 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:24:22 INFO - 2015-11-19 22:24:22,369 DEBUG : BROWSER_OUTPUT: 22:24:23 INFO - 2015-11-19 22:24:23,279 INFO : Browser exited with error code: 0 22:24:23 INFO - 2015-11-19 22:24:23,330 INFO : Completed test kraken (00:01:01) 22:24:23 INFO - 2015-11-19 22:24:23,330 INFO : Starting test v8_7 22:24:23 INFO - 2015-11-19 22:24:23,330 DEBUG : operating with platform_type : linux_ 22:24:23 INFO - 2015-11-19 22:24:23,330 INFO : Initialising browser for v8_7 test... 22:24:23 INFO - 2015-11-19 22:24:23,336 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzXJUx5/profile http://localhost:56039/getInfo.html 22:24:28 INFO - 2015-11-19 22:24:28,043 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:24:28 INFO - 2015-11-19 22:24:28,043 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:24:28 INFO - 2015-11-19 22:24:28,043 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:24:28 INFO - 2015-11-19 22:24:28,043 DEBUG : BROWSER_OUTPUT: __metrics 22:24:29 INFO - 2015-11-19 22:24:29,146 INFO : Browser initialized. 22:24:29 INFO - 2015-11-19 22:24:29,147 INFO : Running cycle 1/1 for v8_7 test... 22:24:29 INFO - 2015-11-19 22:24:29,147 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzXJUx5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:24:41 INFO - 2015-11-19 22:24:41,161 DEBUG : BROWSER_OUTPUT: RSS: Main: 141922304 22:24:41 INFO - 2015-11-19 22:24:41,161 DEBUG : BROWSER_OUTPUT: 22:25:02 INFO - 2015-11-19 22:25:02,543 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56039/tests/v8_7/run.html (next: http://localhost:56039/tests/v8_7/run.html) 22:25:02 INFO - 2015-11-19 22:25:02,793 DEBUG : BROWSER_OUTPUT: RSS: Main: 138874880 22:25:02 INFO - 2015-11-19 22:25:02,793 DEBUG : BROWSER_OUTPUT: 22:25:02 INFO - 2015-11-19 22:25:02,794 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:25:02 INFO - 2015-11-19 22:25:02,795 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:25:02 INFO - 2015-11-19 22:25:02,795 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:25:02 INFO - 2015-11-19 22:25:02,795 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:25:02 INFO - 2015-11-19 22:25:02,795 DEBUG : BROWSER_OUTPUT: |0;Richards;163.23865491348351 22:25:02 INFO - 2015-11-19 22:25:02,795 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;190.1863826550019 22:25:02 INFO - 2015-11-19 22:25:02,795 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.2516056967328 22:25:02 INFO - 2015-11-19 22:25:02,795 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5040.201005025126 22:25:02 INFO - 2015-11-19 22:25:02,796 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1060.4453870625662 22:25:02 INFO - 2015-11-19 22:25:02,796 DEBUG : BROWSER_OUTPUT: |5;Earley;697.8367062107467 22:25:02 INFO - 2015-11-19 22:25:02,796 DEBUG : BROWSER_OUTPUT: |6;Boyer;12195.121951219513 22:25:02 INFO - 2015-11-19 22:25:02,796 DEBUG : BROWSER_OUTPUT: |7;RegExp;25846.153846153848 22:25:02 INFO - 2015-11-19 22:25:02,796 DEBUG : BROWSER_OUTPUT: |8;Splay;662.2516556291391 22:25:02 INFO - 2015-11-19 22:25:02,796 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 22:25:02 INFO - 2015-11-19 22:25:02,797 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:25:02 INFO - 2015-11-19 22:25:02,797 DEBUG : BROWSER_OUTPUT: __startTimestamp1448000702793__endTimestamp 22:25:02 INFO - 2015-11-19 22:25:02,797 DEBUG : BROWSER_OUTPUT: 22:25:02 INFO - 2015-11-19 22:25:02,797 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:25:02 INFO - 2015-11-19 22:25:02,798 DEBUG : BROWSER_OUTPUT: Number of tests: 10 22:25:02 INFO - 2015-11-19 22:25:02,798 DEBUG : BROWSER_OUTPUT: 22:25:02 INFO - 2015-11-19 22:25:02,798 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.24 Median:163.24 stddev:0.00 (0.0%) 22:25:02 INFO - 2015-11-19 22:25:02,798 DEBUG : BROWSER_OUTPUT: Values: 163.2 22:25:02 INFO - 2015-11-19 22:25:02,798 DEBUG : BROWSER_OUTPUT: 22:25:02 INFO - 2015-11-19 22:25:02,799 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:190.19 Median:190.19 stddev:0.00 (0.0%) 22:25:02 INFO - 2015-11-19 22:25:02,799 DEBUG : BROWSER_OUTPUT: Values: 190.2 22:25:02 INFO - 2015-11-19 22:25:02,799 DEBUG : BROWSER_OUTPUT: 22:25:02 INFO - 2015-11-19 22:25:02,799 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.25 Median:279.25 stddev:0.00 (0.0%) 22:25:02 INFO - 2015-11-19 22:25:02,799 DEBUG : BROWSER_OUTPUT: Values: 279.3 22:25:02 INFO - 2015-11-19 22:25:02,799 DEBUG : BROWSER_OUTPUT: 22:25:02 INFO - 2015-11-19 22:25:02,800 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5040.20 Median:5040.20 stddev:0.00 (0.0%) 22:25:02 INFO - 2015-11-19 22:25:02,800 DEBUG : BROWSER_OUTPUT: Values: 5040.2 22:25:02 INFO - 2015-11-19 22:25:02,800 DEBUG : BROWSER_OUTPUT: 22:25:02 INFO - 2015-11-19 22:25:02,800 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1060.45 Median:1060.45 stddev:0.00 (0.0%) 22:25:02 INFO - 2015-11-19 22:25:02,801 DEBUG : BROWSER_OUTPUT: Values: 1060.4 22:25:02 INFO - 2015-11-19 22:25:02,801 DEBUG : BROWSER_OUTPUT: 22:25:02 INFO - 2015-11-19 22:25:02,801 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:697.84 Median:697.84 stddev:0.00 (0.0%) 22:25:02 INFO - 2015-11-19 22:25:02,801 DEBUG : BROWSER_OUTPUT: Values: 697.8 22:25:02 INFO - 2015-11-19 22:25:02,802 DEBUG : BROWSER_OUTPUT: 22:25:02 INFO - 2015-11-19 22:25:02,802 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12195.12 Median:12195.12 stddev:0.00 (0.0%) 22:25:02 INFO - 2015-11-19 22:25:02,803 DEBUG : BROWSER_OUTPUT: Values: 12195.1 22:25:02 INFO - 2015-11-19 22:25:02,803 DEBUG : BROWSER_OUTPUT: 22:25:02 INFO - 2015-11-19 22:25:02,803 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25846.15 Median:25846.15 stddev:0.00 (0.0%) 22:25:02 INFO - 2015-11-19 22:25:02,803 DEBUG : BROWSER_OUTPUT: Values: 25846.2 22:25:02 INFO - 2015-11-19 22:25:02,803 DEBUG : BROWSER_OUTPUT: 22:25:02 INFO - 2015-11-19 22:25:02,803 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:662.25 Median:662.25 stddev:0.00 (0.0%) 22:25:02 INFO - 2015-11-19 22:25:02,804 DEBUG : BROWSER_OUTPUT: Values: 662.3 22:25:02 INFO - 2015-11-19 22:25:02,804 DEBUG : BROWSER_OUTPUT: 22:25:02 INFO - 2015-11-19 22:25:02,804 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 22:25:02 INFO - 2015-11-19 22:25:02,804 DEBUG : BROWSER_OUTPUT: Values: 4830.9 22:25:02 INFO - 2015-11-19 22:25:02,804 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:25:02 INFO - 2015-11-19 22:25:02,804 DEBUG : BROWSER_OUTPUT: 22:25:03 INFO - 2015-11-19 22:25:03,783 INFO : Browser exited with error code: 0 22:25:03 INFO - 2015-11-19 22:25:03,795 INFO : Completed test v8_7 (00:00:40) 22:25:03 INFO - 2015-11-19 22:25:03,816 INFO : Completed test suite (00:20:18) 22:25:03 INFO - 2015-11-19 22:25:03,816 DEBUG : Working with test: dromaeo_css 22:25:03 INFO - 2015-11-19 22:25:03,816 DEBUG : Generating results file: dromaeo_css 22:25:03 INFO - 2015-11-19 22:25:03,817 DEBUG : Working with test: kraken 22:25:03 INFO - 2015-11-19 22:25:03,818 DEBUG : Generating results file: kraken 22:25:03 INFO - 2015-11-19 22:25:03,818 INFO : javascript benchmark 22:25:03 INFO - 2015-11-19 22:25:03,818 DEBUG : Working with test: v8_7 22:25:03 INFO - 2015-11-19 22:25:03,818 DEBUG : Generating results file: v8_7 22:25:03 INFO - 2015-11-19 22:25:03,819 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:25:06 INFO - 2015-11-19 22:25:06,459 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,94,43]] 22:25:06 INFO - 2015-11-19 22:25:06,459 DEBUG : process_Request line: dromaeo_css 6314.96 graph.html#tests=[[72,94,43]] 22:25:06 INFO - 2015-11-19 22:25:06,459 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:25:06 INFO - 2015-11-19 22:25:06,590 DEBUG : process_Request line: kraken 1542.60 graph.html#tests=[[232,94,43]] 22:25:06 INFO - 2015-11-19 22:25:06,590 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:25:06 INFO - 2015-11-19 22:25:06,720 DEBUG : process_Request line: v8_7 21288.80 graph.html#tests=[[230,94,43]] 22:25:06 INFO - 2015-11-19 22:25:06,722 INFO : javascript benchmark 22:25:06 INFO - 2015-11-19 22:25:06,725 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2721.5645496720526, 2750.724927507251, 2787.163850844746, 2793.8463384513857, 2810.6205662235607, 4702.083093796702, 4799.904001919959, 4802.951970480294, 4836.516348365161, 4847.709137451755, 4793.90412191756, 4806.255030470274, 4829.444613869406, 4902.803887844482, 4912.606991440685, 4466.464024317086, 4485.910281794362, 4522.45730512339, 4523.751193684346, 4546.318052292149, 4486.484054333744, 4490.1019796040755, 4531.207038768219, 4555.271156614942, 4556.589906908378, 4304.440422745054, 4341.522432532419, 4410.823567057314, 4454.510003899569, 4461.107778444324, 4441.067375851075, 4521.751303678297, 4524.864254072383, 4529.660275479352, 4537.3647689323525, 4289.571042895716, 4494.348319493655, 4503.234450143484, 4506.864794056183, 4509.954900451019, 4550.135474259913, 4604.470485894131, 4812.037592481518, 4827.710337379768, 4837.443693975168, 5198.428172900978, 5198.636095473318, 5204.739763011834, 5229.529342359206, 5278.155495120763, 5008.398992120932, 5139.203423469368, 5241.397239317489, 5251.947480525184, 5261.631685781997, 4738.4313882334, 4787.473377928425, 4816.060868130681, 4825.227963525819, 4860.878478038077, 5310.9734451327495, 5352.732363381893, 5363.597730170175, 5363.678179309254, 5404.8108316208745, 4800.903981920412, 4892.437369702458, 4913.31213630092, 5142.1772516397195, 5161.870953226125, 5011.223260394645, 5058.4435712071645, 5146.099432599281, 5266.526012658879, 5323.946760532423, 5193.584513238932, 5205.583553315726, 5207.0366982108435, 5219.269302297681, 5219.686818790885, 4886.193778026586, 5165.560927321145, 5166.276721259027, 5168.689878607295, 5206.088934436534, 4205.537390887, 4252.4046633471335, 4293.098449325614, 4293.248681480728, 4325.718828276152, 3775.754575952554, 3797.0, 3798.411246256779, 3817.1602247505502, 3830.4637350770913, 4226.070264541858, 4334.0, 4433.0, 4493.573110554492, 4529.09418116378, 5179.896402071938, 5290.206469029599, 5295.814646487432, 5303.973480132652, 5330.387005494418, 4404.823807047746, 4459.888502787457, 4461.665375096881, 4473.105378924163, 4503.639708823286, 4310.43964284641, 4427.933580996288, 4468.106378724268, 4610.561996610384, 4639.628829693616, 4890.315355850255, 4910.484399138039, 4921.8523444296725, 4924.926126108111, 4964.180910149785, 5182.300389447376, 5182.32629758129, 5188.0, 5199.55803756685, 5247.58019358458, 4780.4741478436645, 4910.06708725341, 4912.435069966999, 4917.532834380728, 4943.505649435027, 5018.623603229699, 5101.51535604117, 5150.562202212854, 5150.716710580954, 5183.714895680774, 5219.712915789668, 5226.97386513065, 5231.450697676689, 5241.030409374278, 5271.71005594696, 4739.123262196505, 4876.561109500162, 5048.621353398436, 5058.418281897481, 5063.746812659426, 4923.286123511999, 4999.950000500094, 5001.4998500149695, 5007.023630392038, 5054.823081192288, 4869.926951095807, 4889.095517329305, 4912.042151780369, 4948.826791062295, 4962.33008543842, 4883.560479556857, 4994.925076123934, 5044.470330615232, 5044.697318160922, 5046.268291097696, 4920.92618610714, 4936.901261974668, 4974.850754477371, 4995.675281106716, 5003.974980125076], "unit": "ms", "name": "dojo.html", "value": 4741.707869268228}, {"lowerIsBetter": false, "replicates": [571.6113043130674, 577.7573419163954, 580.1037397221293, 581.4650521520201, 590.2091197794954, 34243.657563424356, 35195.1201219969, 35226.64773352269, 35251.2949741005, 35340.64659353406, 39072.80463597685, 39435.21129577407, 39556.604433955654, 39586.40620390696, 39702.205955880934, 7860.410469214818, 7959.880601790977, 7996.840063198732, 8005.039395272575, 8005.959970200141, 7860.606969651523, 7914.722984695537, 7940.086890007666, 7953.801154971143, 7964.681412743484, 7882.330001949813, 7928.563928983904, 7936.4047696423, 7961.960190199041, 7977.321927636158, 7828.138904720477, 7901.20987901211, 7912.525248485081, 7913.169117242722, 7927.484713493604, 7742.0, 7884.645190966363, 7920.0, 7921.049474063092, 7953.920460795376, 36228.45657315142, 36299.274014519826, 36709.632903671154, 36734.44898326527, 36739.63260367389, 2945.513990191616, 3018.154916623349, 3023.8941637042817, 3065.0, 3078.7844850860447, 27181.592276115873, 27230.727692723016, 27468.0, 27497.587536186973, 27956.301092472648, 3249.4313495138495, 3276.5904261967253, 3278.1149089745873, 3304.653011433789, 3336.3660904428325, 214031.0, 214102.0, 214295.0, 214566.0, 214639.0, 49936.75031624819, 51233.48766512362, 51872.481275186765, 51893.74053129786, 53390.19914701283, 50320.24519632208, 50338.74830625823, 50576.24135637969, 50758.0, 50883.236751448756, 14079.85920140806, 14285.78571321431, 14347.354369053417, 14361.0, 14363.21002344881, 10497.265191436527, 10545.367277963192, 10577.894221057692, 10617.522211500502, 10636.627718029831, 17251.223694933757, 18069.186886590134, 18104.456866294033, 18239.08804559793, 18279.177437015365, 6885.51801373899, 7072.398846098036, 7072.398846098139, 7179.89230161548, 7294.343509084208, 821.8150916043962, 876.7764220123828, 889.5463313710054, 919.9264058875408, 931.0642803981955, 25657.8717106417, 26089.347766305615, 26324.868375658, 26479.33801654974, 26553.33616659599, 956.9521523923776, 961.3606951377395, 962.5427921737258, 978.0, 1014.0771897573173, 12446.815392807324, 12521.311327876872, 12733.68165795844, 12941.54704585335, 12986.155899866479, 261821.0, 266513.0, 266855.0, 266882.0, 267059.0, 44286.778566106965, 44412.3338149928, 44653.0, 44990.32514512285, 45029.32456013162, 1202.212550779241, 1207.444575495282, 1225.2893321873114, 1247.2267194339386, 1266.7149891274573, 24400.26799196027, 24746.752532474446, 24887.87556062208, 24888.37779055538, 24956.126535571893, 39666.40500392554, 39946.800265998485, 39975.600243997185, 40084.1983160341, 40119.3982090263, 244627.0, 246294.0, 246612.0, 247402.0, 247471.0, 27902.581461278503, 29038.564421534116, 29571.112866614036, 29647.555286670286, 29745.10764677063, 34465.13837154091, 35446.64553354433, 38287.42568861414, 38739.225215496095, 38850.4172437408, 32195.0, 32695.50956735603, 32905.835470822494, 33242.0, 33521.83239083789, 31410.52884206693, 33045.33909321752, 33300.16749581183, 33560.49659255162, 33763.662363377036, 30708.232294192825, 30976.84511577428, 30980.845095774377, 32491.675083248865, 33122.66877331292, 26955.191344259703, 28220.85889570539, 29743.256418588844, 30899.0, 31144.844275779382, 23323.53352932966, 23732.0, 23837.523249534566, 23979.400514987265, 23980.64029039531], "unit": "ms", "name": "ext.html", "value": 16534.967312960332}, {"lowerIsBetter": false, "replicates": [325.17081442322086, 326.75656635806325, 341.8307937570903, 341.9692227699507, 343.59970634211146, 15054.698906021873, 15376.769348459782, 15799.92100039501, 15827.287772050271, 16272.349106035774, 14625.268736563183, 14656.926715366408, 14667.706645867076, 14692.338844751985, 14929.552113436614, 4478.820847166117, 4592.70147440417, 4597.632189424855, 4598.264277715566, 4601.6548758843055, 4726.0784147091335, 4739.289106634015, 4742.786574604151, 4750.928736068944, 4755.144074066667, 3268.509723541476, 3398.4562470004803, 4755.072760811643, 4813.446453657822, 5131.435542090367, 5226.451222621608, 5297.099493086184, 5306.257124002643, 5308.70802105884, 5339.22581225722, 5010.824621138279, 5098.872528186788, 5118.38579370478, 5140.460251673595, 5158.948410515922, 11338.773224535464, 11634.592789252336, 11654.359010254433, 12724.872751272462, 17784.46646600604, 1790.4270633397318, 1806.2594336322177, 1807.8282563156479, 1820.553964278747, 1865.3937470322064, 9011.864822027675, 9158.58786354609, 9340.813183736354, 12360.75278494425, 12596.370181490889, 1696.762453256545, 1813.6916724156792, 1866.318793640325, 1891.4042076745918, 2020.6968954656918, 54575.45424545783, 55126.0, 55503.889922201735, 55978.44021559773, 56373.15440268399, 9789.0, 9886.209103271722, 10077.193824494023, 10092.596296148218, 10125.848112278321, 12591.937040314922, 12594.24434533931, 12595.181313214613, 12597.559085432149, 12605.87394126047, 7388.889166662504, 7468.10382754073, 7553.848923021509, 7570.962145189239, 7600.8479830403085, 6854.246032936373, 6935.861282774316, 7124.750633727795, 7174.748883789042, 7193.2447093055525, 4283.87148385549, 4309.633681137138, 4312.870613881589, 4337.0892112656065, 4357.1939191249085, 1742.6514697060638, 1750.264888746704, 1784.634149999247, 1789.1769785898373, 1823.179569193868, 391.2605176216952, 395.1129713792554, 412.62245045783374, 811.8213992921548, 820.8932838731046, 9332.90667093334, 9594.088561586637, 9650.276229282692, 9826.213902887752, 9833.852492212622, 406.5852830113327, 407.1185882564215, 420.38413723894644, 428.4237700293101, 434.17723414130046, 5322.2548843161985, 5514.310711161105, 5618.157276408489, 5635.830925072254, 5639.295088113986, 472434.0, 478996.0, 479337.0, 482482.0, 487911.0, 69305.0, 71044.64477677578, 71972.0, 73287.2671273291, 75797.24202757902, 1062.9946850265699, 1109.1293334732197, 1111.572044762772, 1113.0761467981556, 1115.9051480624237, 13928.373223204777, 14008.0, 14717.675409212794, 14782.63043423923, 15119.848801511844, 30070.248243793205, 30227.58179345691, 30488.84755576208, 31229.68770312268, 31229.843850780602, 38105.80947095247, 38841.223175535764, 39575.60424395719, 39845.40231896466, 41262.79368603138, 8371.33029357662, 8543.273821724973, 8752.606132723915, 9026.86459703118, 9050.818983620422, 14866.628334291296, 15568.29942652606, 15636.0, 15732.606684832514, 16377.344906204095, 12930.288834113837, 13948.58154255374, 13974.231417272147, 14174.787378189129, 14447.638809029439, 12875.0, 13176.934115329363, 13220.933895330461, 13394.732105357643, 13571.117877337942, 13671.931640341734, 13833.86166138366, 14147.858521414653, 14349.856501434851, 14593.270336483345, 8324.750257492286, 8460.857784199301, 9020.00779914222, 9109.498977556033, 9138.406003609743, 13410.932945335211, 13501.392437340146, 13770.31148442594, 13803.0, 13860.306984650928], "unit": "ms", "name": "jquery.html", "value": 7729.68191703387}, {"lowerIsBetter": false, "replicates": [1402.817633707618, 1412.1456518806121, 1540.6456515001548, 1749.1429199692147, 1758.8241175882406, 6219.657918814475, 6299.811005669826, 7085.468589855762, 7537.246275372453, 7561.319481246694, 7041.119860017498, 7235.855282894339, 7259.382952449035, 7265.055542779432, 7284.708611655527, 2131.744190697115, 2163.102312540294, 2163.4375062483787, 2165.967510487344, 2167.425632207466, 2100.2334148035934, 2165.2421652421685, 2173.3045425463856, 2176.064292354287, 2187.639039558471, 2042.6425375559293, 2047.0992763184227, 2063.576966721826, 2069.813716765491, 2086.238522939124, 2105.95788084239, 2120.8197303229244, 2128.946776330589, 2129.6379615465407, 2133.9359819205292, 2101.2750601042617, 2179.8801065941366, 2182.4980254541542, 2184.2791878679996, 2184.9563008739897, 7419.962900185518, 7502.249775022454, 7524.435667324972, 7536.0, 7548.131964824061, 4311.1808756336195, 4354.847580334705, 4389.100234451929, 4391.824327026915, 4401.317795741633, 2946.720061594145, 2981.403719256136, 3069.877204911801, 3082.9537556936666, 3087.3979573983083, 938.4275591888942, 967.9516024198762, 970.7330484116853, 971.825071487132, 999.2305924438215, 10060.094591486728, 10073.143782778472, 10101.989801019912, 10103.444310562916, 10136.13842823361, 4026.5570787213383, 4121.010957370209, 4199.958000420018, 4207.642350400189, 4216.409702641633, 8565.57172141403, 8640.697575584825, 8642.740717778477, 8646.827063458695, 8647.870281945776, 4481.5070342262325, 4485.192665320274, 4506.887327816765, 4515.525869783691, 4523.773811309421, 3940.054386947112, 4034.2536630722825, 4057.959420405817, 4064.6545043671026, 4066.1257829566784, 3289.5723555937575, 3309.305045940331, 3313.6355000949875, 3321.9169520762175, 3354.714849237842, 1003.2575893838653, 1009.0817356205818, 1010.2625083688948, 1013.1034034879037, 1022.3405903192399, 1114.8773634900153, 1121.9439028048564, 1136.0400461609927, 1138.459231864874, 1216.750566133958, 7086.0, 7087.114110736158, 7088.574685518885, 7092.219855815856, 7097.964510177416, 448.16417381583113, 451.96836221464184, 454.52502135268725, 457.8511983605275, 471.37307381182944, 5108.744562771846, 5153.45888681683, 5153.510416510426, 5176.456472070454, 5183.196604526304, 8470.915290847135, 8640.222379985831, 8681.2186903179, 8770.736877893672, 8840.204381605687, 8698.0, 8705.260052895448, 8707.6516939323, 8782.956085219661, 8787.34094942869, 6710.060591517192, 6746.865062698718, 6795.014722865157, 6861.416779573692, 6870.862582748317, 6909.481788865754, 6920.892657175029, 6954.3045695430055, 6973.755918542826, 6975.476839236976, 7741.380689544711, 7813.179616140451, 7858.292753652198, 7913.44605877583, 7923.762287131395, 8011.959940200261, 8013.63938622775, 8107.513549187068, 8129.715459958873, 8137.389695772959, 5578.191162281365, 6075.3317135115985, 6376.458001069961, 6413.0701048348665, 6445.0332450132855, 6851.109355783717, 6863.313668633096, 6903.896441553481, 6914.792556223321, 6949.131358580177, 6134.723937422737, 6228.844278893064, 6438.967805161132, 6453.09656648079, 6556.967215163893, 6356.9046464304, 6442.323556026549, 6520.152380190545, 6552.017197420425, 6584.736610535525, 6588.571742836892, 6604.273529911802, 6617.139771829631, 6646.03632473279, 6656.600603963778, 6001.939980600313, 6028.3971602839365, 6041.546883983631, 6068.575199736153, 6186.412290832363, 6199.3490683477585, 6279.026750853625, 6288.937110629018, 6299.307076221704, 6301.306856245717], "unit": "ms", "name": "mootools.html", "value": 4125.322294128889}, {"lowerIsBetter": false, "replicates": [310.88808029109515, 315.161669957912, 315.8562853901474, 318.4284209843331, 321.7635038246889, 5534.916976245355, 5586.966411213928, 5679.801206957757, 5718.914216286759, 5725.856853578663, 5590.888182236353, 5621.522170615503, 5649.971750141254, 5652.152177173426, 5665.433456654332, 4238.830446782125, 4344.522102568731, 4346.391505189276, 4353.10761293934, 4353.194658988089, 4330.631896288819, 4337.262665346882, 4342.67429942754, 4352.39066530686, 4358.498772641139, 4290.120525292323, 4306.224879521685, 4307.117041006586, 4312.22379971605, 4313.072689371785, 4281.6360609348085, 4285.378620100084, 4292.763897985609, 4308.892277693051, 4320.654347652212, 3657.6342365763476, 3762.3980163174033, 3762.5484941806885, 3768.6419790119894, 3769.7549659272336, 5296.708681022542, 5402.513773760341, 5403.162509810985, 5405.054115529806, 5423.566114710814, 4887.193613053842, 4897.3878265216845, 4913.803447862081, 4930.03864246472, 4934.087193869145, 5888.97055514724, 5909.497692696126, 5910.08393698973, 5910.468057874812, 5914.053751399799, 3883.8834834954996, 4024.315866302706, 4027.35562310029, 4034.8184331705143, 4079.2453396121814, 6146.969265153691, 6186.288576813679, 6197.225346831646, 6230.283517395467, 6247.375262473762, 4115.9588404116175, 4116.382542618571, 4119.320312148462, 4120.979395103005, 4127.9174416512105, 4177.394277829698, 4178.477690288714, 4180.143070670505, 4183.330667093251, 4186.5604111568455, 4766.1659209638865, 4851.248056551241, 4858.878528036827, 4883.487233840467, 4890.926636100461, 5917.230760001258, 5921.496672782776, 5933.495652869555, 5934.554908381889, 5943.673097979653, 1501.0768377447791, 1515.6210947263185, 1518.1043184521186, 1519.620094976256, 1520.2550750132355, 961.8653388525612, 974.5078735238659, 976.8534719791946, 994.9154321882577, 1008.7629407089328, 5067.189249720101, 5098.0, 5113.667611605234, 5114.948850511447, 5130.7947682093045, 6127.938720612737, 6141.170941922873, 6146.446819786241, 6148.661823599745, 6151.446369826737, 5081.339425874687, 5089.287499750038, 5096.694198348111, 5099.97450012755, 5101.704233095122, 3229.4832826747606, 3291.687289707474, 3323.7839540430277, 3327.667233276653, 3329.8168600727195, 5656.4060773619, 5766.855828604318, 5800.53595712342, 5807.390224026416, 5826.155207494974, 6340.841478963062, 6355.0785136155, 6372.745090196433, 6389.648569328731, 6391.169148010822, 5830.970845145747, 5838.416158384128, 5849.415058494202, 5856.209411729447, 5868.061110222344, 5976.223090998143, 6125.448709616156, 6175.505959523317, 6179.443850053337, 6195.0, 6023.247094113236, 6053.788117416046, 6054.90917636227, 6057.242844644419, 6084.178635884099, 5785.56608254391, 5804.042333015005, 5815.621984570989, 5817.709114544171, 5855.473007429352, 4176.686748493936, 4225.915481690287, 4227.239096962577, 4235.237657221606, 4244.72409293395, 6014.0678194879865, 6117.908231376622, 6150.815475535741, 6155.984262596621, 6172.197614310111, 5893.941060589339, 5912.645241285537, 5914.792982245601, 5930.775959015369, 5930.881382372415, 5889.499392551681, 5891.38140495259, 5919.4968427684125, 5932.872754176693, 5943.227380440515, 5576.86057848557, 5763.596548241583, 5798.652080875161, 5799.478046975623, 5803.419658034331, 5957.642541447527, 5979.372165922689, 5984.431479009487, 5989.490893273946, 5991.910121348271, 5788.9449245517235, 5805.622634528742, 5809.767609295581, 5810.0, 5826.533877289891], "unit": "ms", "name": "prototype.html", "value": 4416.421958962934}, {"lowerIsBetter": false, "replicates": [745.3217572009469, 766.3256334425705, 768.3660979691754, 780.0989856715496, 811.0429692962302, 11515.712107197323, 11875.34685592292, 11893.167478276524, 11925.701857453569, 11975.64073077808, 11192.38441885696, 11208.271462354962, 11289.661310160709, 11292.153088518353, 11309.886901130987, 771.4985259581275, 789.0964845252183, 792.3067316098413, 792.6036981509245, 794.4081659163902, 792.8057625881667, 798.4410912361341, 798.5129071266523, 800.3677095094897, 801.1347744436024, 820.446198815797, 823.8846561481397, 827.3794654009492, 830.8006078541167, 831.2767891934026, 825.4964471672275, 826.2687521543418, 828.995855020727, 832.076395201326, 832.6419639554989, 611.7124951272939, 612.1368869893429, 612.5099920063975, 613.2365205319406, 614.9538784591128, 12705.682357941034, 12739.808902866464, 12766.680832979157, 12806.871931280753, 12850.100492965496, 10951.561937522489, 11244.831327530093, 11414.201005929588, 11453.59912403062, 11908.16642835002, 8967.058458861857, 9000.279977601776, 9185.311101667401, 9264.72205833826, 9485.762855928588, 3037.9848100759355, 3126.3434678717495, 3141.8429078545983, 3142.1673256587023, 3151.9684803151904, 37577.81211093954, 38121.0, 38320.80839595812, 38404.80797596022, 38417.61582384168, 9150.771230719152, 9273.397229180082, 9437.103475169848, 9665.081817227352, 9669.806603867883, 16484.587885302724, 16512.33950641985, 16517.174141292886, 16519.33922643081, 16546.751798723028, 6307.747690092437, 6337.271213810471, 6448.484121270287, 6500.70746816385, 6546.312637173123, 3444.0528854565196, 3448.9827550862087, 3486.8082255475683, 3515.209077957439, 3546.7517273791104, 2738.904138355188, 2748.175547335791, 2769.736874996872, 2770.4736100141313, 2778.8610569471443, 474.4591166070682, 478.12980375715864, 478.19424270104986, 482.879280179955, 483.14242220058975, 573.9626924249994, 574.1072632057192, 580.5877826742975, 597.6145386225946, 628.3527966194827, 7150.606716630636, 7250.4199664026755, 7380.114386273574, 7601.923980760122, 7616.35261002821, 497.49255759125487, 570.224494687225, 584.5119325363285, 600.1447936690199, 604.1511676095093, 3325.201951531615, 3523.5947865995226, 3532.0, 3588.4976103345552, 3601.441776524643, 50347.0, 50995.0, 51121.0, 51168.0, 51998.0, 38301.80849095793, 44329.335059974124, 48958.26562601564, 49726.50273497291, 49988.0, 36616.45075323872, 40672.38991415072, 40782.388264176065, 41212.58787412087, 41396.1720765583, 7450.329470347695, 7786.0, 8003.83992320162, 8033.839323213386, 8238.299744521542, 32418.189545261557, 32507.512387313735, 32600.413954465464, 32746.181345466553, 33588.0, 37006.44490332593, 37097.629023709414, 39999.60000400075, 40173.19653606853, 42523.0, 9380.34337596389, 9550.474723890253, 9560.187384072431, 9803.411795292306, 10081.747956301151, 10639.255252132276, 10735.570577177137, 11310.660680179608, 11551.133664974992, 11614.76770464569, 10389.688309350731, 10630.52162652698, 10656.62701805433, 10742.3017503862, 10967.067799236835, 10946.17903657213, 11102.944485277521, 11130.777384452427, 11152.944235278772, 11194.160437967348, 10132.848007279748, 10439.289362868643, 10471.10995565355, 10513.211509136692, 10773.784524309312, 9488.810223795348, 9496.810063798546, 9609.567569459252, 9979.301448898508, 10017.69946901594, 9311.686435485259, 9510.1440870322, 9517.23862091045, 9601.759956001157, 9607.292077453274], "unit": "ms", "name": "yui.html", "value": 5743.204770141676}], "name": "dromaeo_css", "value": 6314.958798531976}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 107.0, 113.0, 114.0, 112.0, 124.0, 114.0, 112.0, 111.0, 112.0], "unit": "ms", "name": "ai-astar", "value": 113.2}, {"lowerIsBetter": true, "replicates": [159.0, 130.0, 160.0, 167.0, 133.0, 162.0, 162.0, 132.0, 177.0, 138.0], "unit": "ms", "name": "audio-beat-detection", "value": 152.0}, {"lowerIsBetter": true, "replicates": [165.0, 163.0, 164.0, 165.0, 165.0, 163.0, 168.0, 164.0, 166.0, 163.0], "unit": "ms", "name": "audio-dft", "value": 164.6}, {"lowerIsBetter": true, "replicates": [73.0, 75.0, 73.0, 74.0, 73.0, 74.0, 138.0, 72.0, 74.0, 75.0], "unit": "ms", "name": "audio-fft", "value": 80.1}, {"lowerIsBetter": true, "replicates": [91.0, 91.0, 126.0, 92.0, 93.0, 91.0, 126.0, 91.0, 91.0, 131.0], "unit": "ms", "name": "audio-oscillator", "value": 102.3}, {"lowerIsBetter": true, "replicates": [110.0, 111.0, 110.0, 113.0, 111.0, 110.0, 111.0, 110.0, 111.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.7}, {"lowerIsBetter": true, "replicates": [149.0, 150.0, 148.0, 147.0, 148.0, 149.0, 149.0, 147.0, 148.0, 149.0], "unit": "ms", "name": "imaging-darkroom", "value": 148.4}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 72.0, 73.0, 75.0, 73.0, 72.0, 72.0, 71.0, 70.0], "unit": "ms", "name": "json-parse-financial", "value": 72.1}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 70.0, 70.0, 70.0, 70.0, 70.0, 69.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.5}, {"lowerIsBetter": true, "replicates": [82.0, 84.0, 85.0, 86.0, 83.0, 82.0, 92.0, 85.0, 85.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.8}, {"lowerIsBetter": true, "replicates": [133.0, 130.0, 120.0, 124.0, 127.0, 134.0, 127.0, 131.0, 125.0, 129.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 128.0}, {"lowerIsBetter": true, "replicates": [147.0, 161.0, 146.0, 158.0, 160.0, 139.0, 152.0, 146.0, 147.0, 146.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 150.2}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 72.0, 73.0, 70.0, 72.0, 69.0, 68.0, 69.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 70.6}], "name": "kraken", "value": 1542.6}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [163.23865491348351], "unit": "score", "name": "Richards", "value": 216.26005200000003}, {"lowerIsBetter": false, "replicates": [190.1863826550019], "unit": "score", "name": "DeltaBlue", "value": 347.648444}, {"lowerIsBetter": false, "replicates": [279.2516056967328], "unit": "score", "name": "Encrypt", "value": 953.1941609999996}, {"lowerIsBetter": false, "replicates": [5040.201005025126], "unit": "score", "name": "Decrypt", "value": 52.81158424725827}, {"lowerIsBetter": false, "replicates": [1060.4453870625662], "unit": "score", "name": "RayTrace", "value": 697.809627}, {"lowerIsBetter": false, "replicates": [697.8367062107467], "unit": "score", "name": "Earley", "value": 955.041479}, {"lowerIsBetter": false, "replicates": [12195.121951219513], "unit": "score", "name": "Boyer", "value": 54.64996600000001}, {"lowerIsBetter": false, "replicates": [25846.153846153848], "unit": "score", "name": "RegExp", "value": 35.24644345238097}, {"lowerIsBetter": false, "replicates": [662.2516556291391], "unit": "score", "name": "Splay", "value": 123.05141000000002}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 21288.796525100614}]} 22:25:06 INFO - RETURN: dromaeo_css: 6314.96 22:25:06 INFO - RETURN: kraken: 1542.60 22:25:06 INFO - RETURN: v8_7: 21288.80 22:25:06 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,43]]", "result": "21288.80"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,43]]", "result": "1542.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,43]]", "result": "6314.96"}}} 22:25:06 INFO - Return code: 0 22:25:06 INFO - # TBPL SUCCESS # 22:25:06 INFO - Running post-action listener: _resource_record_post_action 22:25:06 INFO - Running post-run listener: _resource_record_post_run 22:25:07 INFO - Total resource usage - Wall time: 1236s; CPU: 13.0%; Read bytes: 4096; Write bytes: 508600320; Read time: 188; Write time: 671168 22:25:07 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 129921024; Read time: 0; Write time: 147708 22:25:07 INFO - run-tests - Wall time: 1222s; CPU: 13.0%; Read bytes: 0; Write bytes: 307777536; Read time: 0; Write time: 372420 22:25:07 INFO - Running post-run listener: _upload_blobber_files 22:25:07 INFO - Blob upload gear active. 22:25:07 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 22:25:07 INFO - Copying logs to upload dir... 22:25:07 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1263.725745 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2015-11-19 22:25:07.403713) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-19 22:25:07.407219) ========= 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=6e558709db315bacd2260379000001b6-1447997902.82259-879392377 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/8lMdDzBPRgevcJGbcutB5A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010108 build_url: 'https://queue.taskcluster.net/v1/task/8lMdDzBPRgevcJGbcutB5A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.07 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-19 22:25:07.488323) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 22:25:07.488642) ========= 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=6e558709db315bacd2260379000001b6-1447997902.82259-879392377 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004612 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 22:25:07.505024) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 22:25:07.505332) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 22:25:07.505598) ========= ========= Total master_lag: 0.52 =========