builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-036 starttime: 1447915664.58 results: success (0) buildid: 20151118222155 builduid: bbe84ce1ae1c442bb848ef7f44f21336 revision: 3423dce2511e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 22:47:44.580629) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 22:47:44.581091) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 22:47:44.581453) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c54e757a4c805d85fea3bc7000001f2-1447913990.296135-670975499 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.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 22:47:44.602341) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 22:47:44.602698) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 22:47:44.615889) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 22:47:44.616219) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c54e757a4c805d85fea3bc7000001f2-1447913990.296135-670975499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004847 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 22:47:44.666069) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 22:47:44.666380) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 22:47:44.666837) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 22:47:44.667130) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c54e757a4c805d85fea3bc7000001f2-1447913990.296135-670975499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-18 22:47:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 47.3M=0s 2015-11-18 22:47:44 (47.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.189389 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 22:47:44.873837) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 22:47:44.874192) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c54e757a4c805d85fea3bc7000001f2-1447913990.296135-670975499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020322 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 22:47:44.923666) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-18 22:47:44.924006) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3423dce2511e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 3423dce2511e --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c54e757a4c805d85fea3bc7000001f2-1447913990.296135-670975499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-18 22:47:45,072 Setting DEBUG logging. 2015-11-18 22:47:45,072 attempt 1/10 2015-11-18 22:47:45,072 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3423dce2511e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-18 22:47:46,161 unpacking tar archive at: fx-team-3423dce2511e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.378497 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-18 22:47:46.315376) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 22:47:46.315718) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 22:47:46.323794) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 22:47:46.324094) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 22:47:46.324542) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2015-11-18 22:47:46.324841) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c54e757a4c805d85fea3bc7000001f2-1447913990.296135-670975499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:47:46 INFO - MultiFileLogger online at 20151118 22:47:46 in /builds/slave/test 22:47:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 22:47:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:47:46 INFO - {'append_to_log': False, 22:47:46 INFO - 'base_work_dir': '/builds/slave/test', 22:47:46 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 22:47:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:47:46 INFO - 'branch': 'Fx-Team-Non-PGO', 22:47:46 INFO - 'buildbot_json_path': 'buildprops.json', 22:47:46 INFO - 'config_files': ('talos/linux_config.py',), 22:47:46 INFO - 'default_actions': ('clobber', 22:47:46 INFO - 'read-buildbot-config', 22:47:46 INFO - 'download-and-extract', 22:47:46 INFO - 'populate-webroot', 22:47:46 INFO - 'create-virtualenv', 22:47:46 INFO - 'install', 22:47:46 INFO - 'run-tests'), 22:47:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:47:46 INFO - 'download_minidump_stackwalk': True, 22:47:46 INFO - 'download_symbols': 'ondemand', 22:47:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:47:46 INFO - 'tooltool.py': '/tools/tooltool.py', 22:47:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:47:46 INFO - '/tools/misc-python/virtualenv.py')}, 22:47:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:47:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:47:46 INFO - 'installer_path': 'installer.exe', 22:47:46 INFO - 'log_level': 'info', 22:47:46 INFO - 'log_name': 'talos', 22:47:46 INFO - 'log_to_console': True, 22:47:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:47:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:47:46 INFO - 'opt_config_files': (), 22:47:46 INFO - 'pip_index': False, 22:47:46 INFO - 'sps_profile': False, 22:47:46 INFO - 'sps_profile_interval': 0, 22:47:46 INFO - 'suite': 'dromaeojs-e10s', 22:47:46 INFO - 'system_bits': '64', 22:47:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:47:46 INFO - 'title': 'talos-linux64-ix-036', 22:47:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:47:46 INFO - 'use_talos_json': True, 22:47:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:47:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:47:46 INFO - 'work_dir': 'build'} 22:47:46 INFO - ##### 22:47:46 INFO - ##### Running clobber step. 22:47:46 INFO - ##### 22:47:46 INFO - Running pre-action listener: _resource_record_pre_action 22:47:46 INFO - Running main action method: clobber 22:47:46 INFO - rmtree: /builds/slave/test/build 22:47:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:47:46 INFO - Running post-action listener: _resource_record_post_action 22:47:46 INFO - ##### 22:47:46 INFO - ##### Running read-buildbot-config step. 22:47:46 INFO - ##### 22:47:46 INFO - Running pre-action listener: _resource_record_pre_action 22:47:46 INFO - Running main action method: read_buildbot_config 22:47:46 INFO - Using buildbot properties: 22:47:46 INFO - { 22:47:46 INFO - "properties": { 22:47:46 INFO - "buildnumber": 700, 22:47:46 INFO - "product": "firefox", 22:47:46 INFO - "script_repo_revision": "production", 22:47:46 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 22:47:46 INFO - "repository": "", 22:47:46 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 22:47:46 INFO - "buildid": "20151118222155", 22:47:46 INFO - "slavename": "talos-linux64-ix-036", 22:47:46 INFO - "pgo_build": "False", 22:47:46 INFO - "basedir": "/builds/slave/test", 22:47:46 INFO - "project": "", 22:47:46 INFO - "platform": "ubuntu64_hw", 22:47:46 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:47:46 INFO - "slavebuilddir": "test", 22:47:46 INFO - "scheduler": "tests-fx-team-linux64-talos", 22:47:46 INFO - "branch": "fx-team", 22:47:46 INFO - "repo_path": "integration/fx-team", 22:47:46 INFO - "stage_platform": "linux64", 22:47:46 INFO - "builduid": "bbe84ce1ae1c442bb848ef7f44f21336", 22:47:46 INFO - "revision": "3423dce2511e" 22:47:46 INFO - }, 22:47:46 INFO - "sourcestamp": { 22:47:46 INFO - "repository": "", 22:47:46 INFO - "hasPatch": false, 22:47:46 INFO - "project": "", 22:47:46 INFO - "branch": "fx-team-linux64-talos", 22:47:46 INFO - "changes": [ 22:47:46 INFO - { 22:47:46 INFO - "category": null, 22:47:46 INFO - "files": [ 22:47:46 INFO - { 22:47:46 INFO - "url": null, 22:47:46 INFO - "name": "https://queue.taskcluster.net/v1/task/GSTTXjJ6QiC_BQssQfh9Gw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 22:47:46 INFO - } 22:47:46 INFO - ], 22:47:46 INFO - "repository": "", 22:47:46 INFO - "rev": "3423dce2511e", 22:47:46 INFO - "who": "mozci-bot@mozilla.com", 22:47:46 INFO - "when": 1447915619, 22:47:46 INFO - "number": 6681292, 22:47:46 INFO - "comments": "", 22:47:46 INFO - "project": "", 22:47:46 INFO - "at": "Wed 18 Nov 2015 22:46:59", 22:47:46 INFO - "branch": "fx-team-linux64-talos", 22:47:46 INFO - "revlink": "", 22:47:46 INFO - "properties": [ 22:47:46 INFO - [ 22:47:46 INFO - "buildid", 22:47:46 INFO - "20151118222155", 22:47:46 INFO - "Change" 22:47:46 INFO - ], 22:47:46 INFO - [ 22:47:46 INFO - "builduid", 22:47:46 INFO - "bbe84ce1ae1c442bb848ef7f44f21336", 22:47:46 INFO - "Change" 22:47:46 INFO - ], 22:47:46 INFO - [ 22:47:46 INFO - "pgo_build", 22:47:46 INFO - "False", 22:47:46 INFO - "Change" 22:47:46 INFO - ] 22:47:46 INFO - ], 22:47:46 INFO - "revision": "3423dce2511e" 22:47:46 INFO - } 22:47:46 INFO - ], 22:47:46 INFO - "revision": "3423dce2511e" 22:47:46 INFO - } 22:47:46 INFO - } 22:47:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/GSTTXjJ6QiC_BQssQfh9Gw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 22:47:46 INFO - Running post-action listener: _resource_record_post_action 22:47:46 INFO - ##### 22:47:46 INFO - ##### Running download-and-extract step. 22:47:46 INFO - ##### 22:47:46 INFO - Running pre-action listener: _resource_record_pre_action 22:47:46 INFO - Running main action method: download_and_extract 22:47:46 INFO - mkdir: /builds/slave/test/build/tests 22:47:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:47:46 INFO - https://queue.taskcluster.net/v1/task/GSTTXjJ6QiC_BQssQfh9Gw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:47:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GSTTXjJ6QiC_BQssQfh9Gw/artifacts/public/build/test_packages.json 22:47:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GSTTXjJ6QiC_BQssQfh9Gw/artifacts/public/build/test_packages.json 22:47:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GSTTXjJ6QiC_BQssQfh9Gw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 22:47:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GSTTXjJ6QiC_BQssQfh9Gw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 22:47:48 INFO - Downloaded 1302 bytes. 22:47:48 INFO - Reading from file /builds/slave/test/build/test_packages.json 22:47:48 INFO - Using the following test package requirements: 22:47:48 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 22:47:48 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:47:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:47:48 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:47:48 INFO - u'jsshell-linux-x86_64.zip'], 22:47:48 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:47:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:47:48 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 22:47:48 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:47:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:47:48 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:47:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:47:48 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:47:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:47:48 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 22:47:48 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:47:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:47:48 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:47:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:47:48 INFO - https://queue.taskcluster.net/v1/task/GSTTXjJ6QiC_BQssQfh9Gw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:47:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GSTTXjJ6QiC_BQssQfh9Gw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:47:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GSTTXjJ6QiC_BQssQfh9Gw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:47:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GSTTXjJ6QiC_BQssQfh9Gw/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:47:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GSTTXjJ6QiC_BQssQfh9Gw/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:47:50 INFO - Downloaded 21291001 bytes. 22:47:50 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:47:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:47:50 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:47:51 INFO - Return code: 0 22:47:51 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:47:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:47:51 INFO - https://queue.taskcluster.net/v1/task/GSTTXjJ6QiC_BQssQfh9Gw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:47:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GSTTXjJ6QiC_BQssQfh9Gw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:47:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GSTTXjJ6QiC_BQssQfh9Gw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:47:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GSTTXjJ6QiC_BQssQfh9Gw/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:47:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GSTTXjJ6QiC_BQssQfh9Gw/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:47:59 INFO - Downloaded 21291001 bytes. 22:47:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 22:47:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:47:59 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 22:48:00 INFO - Return code: 0 22:48:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:48:00 INFO - https://queue.taskcluster.net/v1/task/GSTTXjJ6QiC_BQssQfh9Gw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:48:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GSTTXjJ6QiC_BQssQfh9Gw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 22:48:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GSTTXjJ6QiC_BQssQfh9Gw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 22:48:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GSTTXjJ6QiC_BQssQfh9Gw/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:48:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GSTTXjJ6QiC_BQssQfh9Gw/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:48:01 INFO - Downloaded 11130997 bytes. 22:48:01 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:48:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 22:48:01 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:48:02 INFO - Return code: 0 22:48:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:48:02 INFO - https://queue.taskcluster.net/v1/task/GSTTXjJ6QiC_BQssQfh9Gw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:48:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GSTTXjJ6QiC_BQssQfh9Gw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:48:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GSTTXjJ6QiC_BQssQfh9Gw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:48:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GSTTXjJ6QiC_BQssQfh9Gw/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:48:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GSTTXjJ6QiC_BQssQfh9Gw/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:48:03 INFO - Downloaded 55666137 bytes. 22:48:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GSTTXjJ6QiC_BQssQfh9Gw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:48:03 INFO - mkdir: /builds/slave/test/properties 22:48:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:48:03 INFO - Writing to file /builds/slave/test/properties/build_url 22:48:03 INFO - Contents: 22:48:03 INFO - build_url:https://queue.taskcluster.net/v1/task/GSTTXjJ6QiC_BQssQfh9Gw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:48:03 INFO - Running post-action listener: _resource_record_post_action 22:48:03 INFO - Running post-action listener: set_extra_try_arguments 22:48:03 INFO - ##### 22:48:03 INFO - ##### Running populate-webroot step. 22:48:03 INFO - ##### 22:48:03 INFO - Running pre-action listener: _resource_record_pre_action 22:48:03 INFO - Running main action method: populate_webroot 22:48:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:48:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:48:03 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 22:48:03 INFO - '../fennec_ids.txt'], 22:48:03 INFO - 'tests': ['tcheck2']}, 22:48:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:48:03 INFO - '--tppagecycles', 22:48:03 INFO - '7'], 22:48:03 INFO - 'tests': ['tsvgm']}}, 22:48:03 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:48:03 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:48:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:48:03 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:48:03 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:48:03 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:48:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:48:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:48:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:48:03 INFO - 'talos_options': ['--e10s'], 22:48:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:48:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:48:03 INFO - 'tests': ['damp', 'tps']}, 22:48:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:48:03 INFO - 'talos_options': ['--e10s'], 22:48:03 INFO - 'tests': ['damp', 'tps']}, 22:48:03 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:48:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:48:03 INFO - 'other': {'tests': ['a11yr', 22:48:03 INFO - 'ts_paint', 22:48:03 INFO - 'tpaint', 22:48:03 INFO - 'sessionrestore', 22:48:03 INFO - 'sessionrestore_no_auto_restore']}, 22:48:03 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:48:03 INFO - 'tests': ['a11yr', 22:48:03 INFO - 'ts_paint', 22:48:03 INFO - 'tpaint', 22:48:03 INFO - 'sessionrestore', 22:48:03 INFO - 'sessionrestore_no_auto_restore']}, 22:48:03 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:48:03 INFO - 'tests': ['a11yr', 22:48:03 INFO - 'ts_paint', 22:48:03 INFO - 'tpaint', 22:48:03 INFO - 'sessionrestore', 22:48:03 INFO - 'sessionrestore_no_auto_restore']}, 22:48:03 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:48:03 INFO - 'tests': ['a11yr', 22:48:03 INFO - 'ts_paint', 22:48:03 INFO - 'tpaint', 22:48:03 INFO - 'sessionrestore', 22:48:03 INFO - 'sessionrestore_no_auto_restore']}, 22:48:03 INFO - 'other_l64': {'tests': ['a11yr', 22:48:03 INFO - 'ts_paint', 22:48:03 INFO - 'tpaint', 22:48:03 INFO - 'sessionrestore', 22:48:03 INFO - 'sessionrestore_no_auto_restore']}, 22:48:03 INFO - 'other_nol64': {'tests': ['a11yr', 22:48:03 INFO - 'ts_paint', 22:48:03 INFO - 'tpaint', 22:48:03 INFO - 'sessionrestore', 22:48:03 INFO - 'sessionrestore_no_auto_restore']}, 22:48:03 INFO - 'svgr': {'tests': ['tsvgx', 22:48:03 INFO - 'tsvgr_opacity', 22:48:03 INFO - 'tart', 22:48:03 INFO - 'tscrollx', 22:48:03 INFO - 'cart']}, 22:48:03 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:48:03 INFO - 'tests': ['tsvgx', 22:48:03 INFO - 'tsvgr_opacity', 22:48:03 INFO - 'tart', 22:48:03 INFO - 'tscrollx', 22:48:03 INFO - 'cart']}, 22:48:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:48:03 INFO - 'tests': ['tp5o']}, 22:48:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:48:03 INFO - 'talos_options': ['--e10s'], 22:48:03 INFO - 'tests': ['tp5o']}, 22:48:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:48:03 INFO - 'talos_options': ['--xperf_path', 22:48:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:48:03 INFO - 'tests': ['tp5n']}, 22:48:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:48:03 INFO - 'talos_options': ['--e10s', 22:48:03 INFO - '--xperf_path', 22:48:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:48:03 INFO - 'tests': ['tp5n']}}, 22:48:03 INFO - 'talos.zip': {'path': '', 22:48:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:48:03 INFO - Running post-action listener: _resource_record_post_action 22:48:03 INFO - ##### 22:48:03 INFO - ##### Running create-virtualenv step. 22:48:03 INFO - ##### 22:48:03 INFO - Running pre-action listener: _resource_record_pre_action 22:48:03 INFO - Running main action method: create_virtualenv 22:48:03 INFO - Creating virtualenv /builds/slave/test/build/venv 22:48:03 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:48:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:48:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:48:03 INFO - Using real prefix '/usr' 22:48:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:48:03 INFO - Installing distribute.............................................................................................................................................................................................done. 22:48:06 INFO - Installing pip.................done. 22:48:06 INFO - Return code: 0 22:48:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:48:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:48:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:48:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:48:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:48:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:48:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:48:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5eaa92ec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10096c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ba900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100b70>, '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 0x1151dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1152250>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1447913990.296135-670975499', '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:48:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 22:48:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:48:06 INFO - Using env: {'DISPLAY': ':0', 22:48:06 INFO - 'HOME': '/home/cltbld', 22:48:06 INFO - 'LANG': 'en_US.UTF-8', 22:48:06 INFO - 'LANGUAGE': 'en_US:en', 22:48:06 INFO - 'LOGNAME': 'cltbld', 22:48:06 INFO - 'MAIL': '/var/mail/cltbld', 22:48:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:48:06 INFO - 'MOZ_NO_REMOTE': '1', 22:48:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:48:06 INFO - 'NO_EM_RESTART': '1', 22:48:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:48:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:48:06 INFO - 'PWD': '/builds/slave/test', 22:48:06 INFO - 'SHELL': '/bin/bash', 22:48:06 INFO - 'SHLVL': '1', 22:48:06 INFO - 'TERM': 'linux', 22:48:06 INFO - 'TMOUT': '86400', 22:48:06 INFO - 'USER': 'cltbld', 22:48:06 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1447913990.296135-670975499', 22:48:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:48:06 INFO - '_': '/tools/buildbot/bin/python'} 22:48:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:48:06 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:48:06 INFO - Cleaning up... 22:48:06 INFO - Return code: 0 22:48:06 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:48:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:48:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:48:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:48:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:48:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:48:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:48:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5eaa92ec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10096c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ba900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100b70>, '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 0x1151dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1152250>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1447913990.296135-670975499', '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:48:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 22:48:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 22:48:06 INFO - Using env: {'DISPLAY': ':0', 22:48:06 INFO - 'HOME': '/home/cltbld', 22:48:06 INFO - 'LANG': 'en_US.UTF-8', 22:48:06 INFO - 'LANGUAGE': 'en_US:en', 22:48:06 INFO - 'LOGNAME': 'cltbld', 22:48:06 INFO - 'MAIL': '/var/mail/cltbld', 22:48:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:48:06 INFO - 'MOZ_NO_REMOTE': '1', 22:48:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:48:06 INFO - 'NO_EM_RESTART': '1', 22:48:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:48:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:48:06 INFO - 'PWD': '/builds/slave/test', 22:48:06 INFO - 'SHELL': '/bin/bash', 22:48:06 INFO - 'SHLVL': '1', 22:48:06 INFO - 'TERM': 'linux', 22:48:06 INFO - 'TMOUT': '86400', 22:48:06 INFO - 'USER': 'cltbld', 22:48:06 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1447913990.296135-670975499', 22:48:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:48:06 INFO - '_': '/tools/buildbot/bin/python'} 22:48:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:48:06 INFO - Downloading/unpacking psutil>=0.7.1 22:48:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:48:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:48:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:48:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:48:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:48:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:48:08 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 22:48:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 22:48:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:48:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:48:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:48:08 INFO - Installing collected packages: psutil 22:48:08 INFO - Running setup.py install for psutil 22:48:08 INFO - building 'psutil._psutil_linux' extension 22:48:08 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:48:08 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:48:08 INFO - building 'psutil._psutil_posix' extension 22:48:08 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:48:08 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:48:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:48:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:48:08 INFO - Successfully installed psutil 22:48:08 INFO - Cleaning up... 22:48:08 INFO - Return code: 0 22:48:08 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:48:08 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:48:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:48:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:48:08 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:48:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:48:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:48:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5eaa92ec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10096c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ba900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100b70>, '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 0x1151dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1152250>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1447913990.296135-670975499', '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:48:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 22:48:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 22:48:09 INFO - Using env: {'DISPLAY': ':0', 22:48:09 INFO - 'HOME': '/home/cltbld', 22:48:09 INFO - 'LANG': 'en_US.UTF-8', 22:48:09 INFO - 'LANGUAGE': 'en_US:en', 22:48:09 INFO - 'LOGNAME': 'cltbld', 22:48:09 INFO - 'MAIL': '/var/mail/cltbld', 22:48:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:48:09 INFO - 'MOZ_NO_REMOTE': '1', 22:48:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:48:09 INFO - 'NO_EM_RESTART': '1', 22:48:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:48:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:48:09 INFO - 'PWD': '/builds/slave/test', 22:48:09 INFO - 'SHELL': '/bin/bash', 22:48:09 INFO - 'SHLVL': '1', 22:48:09 INFO - 'TERM': 'linux', 22:48:09 INFO - 'TMOUT': '86400', 22:48:09 INFO - 'USER': 'cltbld', 22:48:09 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1447913990.296135-670975499', 22:48:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:48:09 INFO - '_': '/tools/buildbot/bin/python'} 22:48:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:48:09 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:48:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:48:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:48:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:48:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:48:10 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:48:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 22:48:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:48:10 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:48:10 INFO - Installing collected packages: mozsystemmonitor 22:48:10 INFO - Running setup.py install for mozsystemmonitor 22:48:11 INFO - Successfully installed mozsystemmonitor 22:48:11 INFO - Cleaning up... 22:48:11 INFO - Return code: 0 22:48:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:48: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:48:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:48:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:48: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:48:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:48:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:48:11 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 0x7f5eaa92ec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10096c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ba900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100b70>, '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 0x1151dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1152250>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1447913990.296135-670975499', '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:48:11 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:48:11 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:48:11 INFO - Using env: {'DISPLAY': ':0', 22:48:11 INFO - 'HOME': '/home/cltbld', 22:48:11 INFO - 'LANG': 'en_US.UTF-8', 22:48:11 INFO - 'LANGUAGE': 'en_US:en', 22:48:11 INFO - 'LOGNAME': 'cltbld', 22:48:11 INFO - 'MAIL': '/var/mail/cltbld', 22:48:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:48:11 INFO - 'MOZ_NO_REMOTE': '1', 22:48:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:48:11 INFO - 'NO_EM_RESTART': '1', 22:48:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:48:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:48:11 INFO - 'PWD': '/builds/slave/test', 22:48:11 INFO - 'SHELL': '/bin/bash', 22:48:11 INFO - 'SHLVL': '1', 22:48:11 INFO - 'TERM': 'linux', 22:48:11 INFO - 'TMOUT': '86400', 22:48:11 INFO - 'USER': 'cltbld', 22:48:11 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1447913990.296135-670975499', 22:48:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:48:11 INFO - '_': '/tools/buildbot/bin/python'} 22:48:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:48:11 INFO - Downloading/unpacking blobuploader==1.2.4 22:48:11 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:48:11 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:48:11 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:48:11 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:48:11 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:48:11 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:48:12 INFO - Downloading blobuploader-1.2.4.tar.gz 22:48:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 22:48:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:48:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:48:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:48:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:48:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:48:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:48:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 22:48:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:48:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:48:13 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:48:13 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:48:13 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:48:13 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:48:13 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:48:13 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:48:13 INFO - Downloading docopt-0.6.1.tar.gz 22:48:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 22:48:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:48:13 INFO - Installing collected packages: blobuploader, requests, docopt 22:48:13 INFO - Running setup.py install for blobuploader 22:48:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:48:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:48:13 INFO - Running setup.py install for requests 22:48:14 INFO - Running setup.py install for docopt 22:48:14 INFO - Successfully installed blobuploader requests docopt 22:48:14 INFO - Cleaning up... 22:48:14 INFO - Return code: 0 22:48:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:48:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:48:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:48:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:48:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:48:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:48:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:48:14 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 0x7f5eaa92ec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10096c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ba900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100b70>, '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 0x1151dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1152250>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1447913990.296135-670975499', '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:48:14 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:48:14 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:48:14 INFO - Using env: {'DISPLAY': ':0', 22:48:14 INFO - 'HOME': '/home/cltbld', 22:48:14 INFO - 'LANG': 'en_US.UTF-8', 22:48:14 INFO - 'LANGUAGE': 'en_US:en', 22:48:14 INFO - 'LOGNAME': 'cltbld', 22:48:14 INFO - 'MAIL': '/var/mail/cltbld', 22:48:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:48:14 INFO - 'MOZ_NO_REMOTE': '1', 22:48:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:48:14 INFO - 'NO_EM_RESTART': '1', 22:48:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:48:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:48:14 INFO - 'PWD': '/builds/slave/test', 22:48:14 INFO - 'SHELL': '/bin/bash', 22:48:14 INFO - 'SHLVL': '1', 22:48:14 INFO - 'TERM': 'linux', 22:48:14 INFO - 'TMOUT': '86400', 22:48:14 INFO - 'USER': 'cltbld', 22:48:14 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1447913990.296135-670975499', 22:48:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:48:14 INFO - '_': '/tools/buildbot/bin/python'} 22:48:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:48:14 INFO - Running setup.py (path:/tmp/pip-RtVial-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:48:14 INFO - Running setup.py (path:/tmp/pip-Si1hTU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:48:14 INFO - Running setup.py (path:/tmp/pip-_6tv98-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:48:14 INFO - Running setup.py (path:/tmp/pip-rtJ0K2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:48:14 INFO - Running setup.py (path:/tmp/pip-k8sjbX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:48:14 INFO - Running setup.py (path:/tmp/pip-J8nTjK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:48:14 INFO - Running setup.py (path:/tmp/pip-elW4al-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:48:14 INFO - Running setup.py (path:/tmp/pip-4OfopM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:48:15 INFO - Running setup.py (path:/tmp/pip-tsHlNw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:48:15 INFO - Running setup.py (path:/tmp/pip-VywbU9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:48:15 INFO - Running setup.py (path:/tmp/pip-ccyjD7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:48:15 INFO - Running setup.py (path:/tmp/pip-mi6itP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:48:15 INFO - Running setup.py (path:/tmp/pip-pXsKXy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:48:15 INFO - Running setup.py (path:/tmp/pip-FEa72X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:48:15 INFO - Running setup.py (path:/tmp/pip-vFU9Ho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:48:15 INFO - Running setup.py (path:/tmp/pip-cpkI7r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:48:15 INFO - Running setup.py (path:/tmp/pip-sGacBt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:48:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:48:15 INFO - Running setup.py install for manifestparser 22:48:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:48:15 INFO - Running setup.py install for mozcrash 22:48:15 INFO - Running setup.py install for mozdebug 22:48:15 INFO - Running setup.py install for mozdevice 22:48:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:48:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:48:16 INFO - Running setup.py install for mozfile 22:48:16 INFO - Running setup.py install for mozhttpd 22:48:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:48:16 INFO - Running setup.py install for mozinfo 22:48:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:48:16 INFO - Running setup.py install for mozInstall 22:48:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:48:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:48:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:48:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:48:16 INFO - Running setup.py install for mozleak 22:48:16 INFO - Running setup.py install for mozlog 22:48:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:48:16 INFO - Running setup.py install for moznetwork 22:48:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:48:16 INFO - Running setup.py install for mozprocess 22:48:16 INFO - Running setup.py install for mozprofile 22:48:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:48:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:48:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:48:17 INFO - Running setup.py install for mozrunner 22:48:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:48:17 INFO - Running setup.py install for mozscreenshot 22:48:17 INFO - Running setup.py install for moztest 22:48:17 INFO - Running setup.py install for mozversion 22:48:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:48:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:48:17 INFO - Cleaning up... 22:48:17 INFO - Return code: 0 22:48:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:48:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:48:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:48:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:48:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:48:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:48:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:48:17 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 0x7f5eaa92ec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10096c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ba900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100b70>, '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 0x1151dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1152250>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1447913990.296135-670975499', '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:48:17 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:48:17 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:48:17 INFO - Using env: {'DISPLAY': ':0', 22:48:17 INFO - 'HOME': '/home/cltbld', 22:48:17 INFO - 'LANG': 'en_US.UTF-8', 22:48:17 INFO - 'LANGUAGE': 'en_US:en', 22:48:17 INFO - 'LOGNAME': 'cltbld', 22:48:17 INFO - 'MAIL': '/var/mail/cltbld', 22:48:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:48:17 INFO - 'MOZ_NO_REMOTE': '1', 22:48:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:48:17 INFO - 'NO_EM_RESTART': '1', 22:48:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:48:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:48:17 INFO - 'PWD': '/builds/slave/test', 22:48:17 INFO - 'SHELL': '/bin/bash', 22:48:17 INFO - 'SHLVL': '1', 22:48:17 INFO - 'TERM': 'linux', 22:48:17 INFO - 'TMOUT': '86400', 22:48:17 INFO - 'USER': 'cltbld', 22:48:17 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1447913990.296135-670975499', 22:48:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:48:17 INFO - '_': '/tools/buildbot/bin/python'} 22:48:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:48:17 INFO - Running setup.py (path:/tmp/pip-vRN4yv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:48:17 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:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:48:17 INFO - Running setup.py (path:/tmp/pip-0e77Dp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:48:17 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:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:48:17 INFO - Running setup.py (path:/tmp/pip-xQzSi7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:48:17 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:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:48:17 INFO - Running setup.py (path:/tmp/pip-eteE1A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:48:17 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:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:48:17 INFO - Running setup.py (path:/tmp/pip-yz_Q3q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:48:18 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:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:48:18 INFO - Running setup.py (path:/tmp/pip-kVpAop-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:48:18 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:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:48:18 INFO - Running setup.py (path:/tmp/pip-fqSrrn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:48:18 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:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:48:18 INFO - Running setup.py (path:/tmp/pip-LT3n_o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:48:18 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:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:48:18 INFO - Running setup.py (path:/tmp/pip-8a_ibL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:48:18 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:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:48:18 INFO - Running setup.py (path:/tmp/pip-G82ADC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:48:18 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:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:48:18 INFO - Running setup.py (path:/tmp/pip-6jBH1Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:48:18 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:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:48:18 INFO - Running setup.py (path:/tmp/pip-TsmzMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:48:18 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:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:48:18 INFO - Running setup.py (path:/tmp/pip-mqekqO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:48:18 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:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:48:18 INFO - Running setup.py (path:/tmp/pip-GXCBbZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:48:18 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:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:48:18 INFO - Running setup.py (path:/tmp/pip-T5fk3j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:48:18 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:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:48:18 INFO - Running setup.py (path:/tmp/pip-brnmec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:48:18 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:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:48:18 INFO - Running setup.py (path:/tmp/pip-imv5fh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:48:18 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:48:18 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:48:18 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:48:18 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:48:18 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:48:18 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:48:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:48: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:48: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:48: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:48: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:48: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:48: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:48:20 INFO - Downloading blessings-1.5.1.tar.gz 22:48:20 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:48:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:48:20 INFO - Installing collected packages: blessings 22:48:20 INFO - Running setup.py install for blessings 22:48:20 INFO - Successfully installed blessings 22:48:20 INFO - Cleaning up... 22:48:20 INFO - Return code: 0 22:48:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:48:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:48:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:48:21 INFO - Reading from file tmpfile_stdout 22:48:21 INFO - Current package versions: 22:48:21 INFO - argparse == 1.2.1 22:48:21 INFO - blessings == 1.5.1 22:48:21 INFO - blobuploader == 1.2.4 22:48:21 INFO - docopt == 0.6.1 22:48:21 INFO - manifestparser == 1.1 22:48:21 INFO - mozInstall == 1.12 22:48:21 INFO - mozcrash == 0.16 22:48:21 INFO - mozdebug == 0.1 22:48:21 INFO - mozdevice == 0.47 22:48:21 INFO - mozfile == 1.2 22:48:21 INFO - mozhttpd == 0.7 22:48:21 INFO - mozinfo == 0.9 22:48:21 INFO - mozleak == 0.1 22:48:21 INFO - mozlog == 3.0 22:48:21 INFO - moznetwork == 0.27 22:48:21 INFO - mozprocess == 0.22 22:48:21 INFO - mozprofile == 0.27 22:48:21 INFO - mozrunner == 6.11 22:48:21 INFO - mozscreenshot == 0.1 22:48:21 INFO - mozsystemmonitor == 0.0 22:48:21 INFO - moztest == 0.7 22:48:21 INFO - mozversion == 1.4 22:48:21 INFO - psutil == 3.1.1 22:48:21 INFO - requests == 1.2.3 22:48:21 INFO - wsgiref == 0.1.2 22:48:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:48:21 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:48:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:48:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:48:21 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:48:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:48:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:48:21 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 0x7f5eaa92ec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10096c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ba900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100b70>, '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 0x1151dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1152250>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1447913990.296135-670975499', '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:48:21 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:48:21 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:48:21 INFO - Using env: {'DISPLAY': ':0', 22:48:21 INFO - 'HOME': '/home/cltbld', 22:48:21 INFO - 'LANG': 'en_US.UTF-8', 22:48:21 INFO - 'LANGUAGE': 'en_US:en', 22:48:21 INFO - 'LOGNAME': 'cltbld', 22:48:21 INFO - 'MAIL': '/var/mail/cltbld', 22:48:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:48:21 INFO - 'MOZ_NO_REMOTE': '1', 22:48:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:48:21 INFO - 'NO_EM_RESTART': '1', 22:48:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:48:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:48:21 INFO - 'PWD': '/builds/slave/test', 22:48:21 INFO - 'SHELL': '/bin/bash', 22:48:21 INFO - 'SHLVL': '1', 22:48:21 INFO - 'TERM': 'linux', 22:48:21 INFO - 'TMOUT': '86400', 22:48:21 INFO - 'USER': 'cltbld', 22:48:21 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1447913990.296135-670975499', 22:48:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:48:21 INFO - '_': '/tools/buildbot/bin/python'} 22:48:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:48:21 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:48:21 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:48:21 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:48:21 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:48:21 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:48:21 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:48:21 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:48:21 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:48:21 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:48:21 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:48:21 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:48:21 INFO - Cleaning up... 22:48:21 INFO - Return code: 0 22:48:21 INFO - Running post-action listener: _resource_record_post_action 22:48:21 INFO - Running post-action listener: _start_resource_monitoring 22:48:21 INFO - Starting resource monitoring. 22:48:21 INFO - ##### 22:48:21 INFO - ##### Running install step. 22:48:21 INFO - ##### 22:48:21 INFO - Running pre-action listener: _resource_record_pre_action 22:48:21 INFO - Running main action method: install 22:48:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:48:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:48:21 INFO - Reading from file tmpfile_stdout 22:48:21 INFO - Detecting whether we're running mozinstall >=1.0... 22:48:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:48:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:48:21 INFO - Reading from file tmpfile_stdout 22:48:21 INFO - Output received: 22:48:21 INFO - Usage: mozinstall [options] installer 22:48:21 INFO - Options: 22:48:21 INFO - -h, --help show this help message and exit 22:48:21 INFO - -d DEST, --destination=DEST 22:48:21 INFO - Directory to install application into. [default: 22:48:21 INFO - "/builds/slave/test"] 22:48:21 INFO - --app=APP Application being installed. [default: firefox] 22:48:21 INFO - mkdir: /builds/slave/test/build/application 22:48:21 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:48:21 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:48:35 INFO - Reading from file tmpfile_stdout 22:48:35 INFO - Output received: 22:48:35 INFO - /builds/slave/test/build/application/firefox/firefox 22:48:35 INFO - Running post-action listener: _resource_record_post_action 22:48:35 INFO - ##### 22:48:35 INFO - ##### Running run-tests step. 22:48:35 INFO - ##### 22:48:35 INFO - Running pre-action listener: _resource_record_pre_action 22:48:35 INFO - Running main action method: run_tests 22:48:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:48:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:48:35 INFO - Python 2.7.3 22:48:35 INFO - Return code: 0 22:48:35 INFO - grabbing minidump binary from tooltool 22:48:35 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:48:35 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 0x1100b70>, '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 0x1151dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1152250>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:48:35 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:48:35 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:48:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:48:35 INFO - Return code: 0 22:48:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:48:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:48:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:48:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:48:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:48:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GSTTXjJ6QiC_BQssQfh9Gw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost'] in /builds/slave/test/build 22:48:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GSTTXjJ6QiC_BQssQfh9Gw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --webServer localhost 22:48:35 INFO - Using env: {'DISPLAY': ':0', 22:48:35 INFO - 'HOME': '/home/cltbld', 22:48:35 INFO - 'LANG': 'en_US.UTF-8', 22:48:35 INFO - 'LANGUAGE': 'en_US:en', 22:48:35 INFO - 'LOGNAME': 'cltbld', 22:48:35 INFO - 'MAIL': '/var/mail/cltbld', 22:48:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:48:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:48:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:48:35 INFO - 'MOZ_NO_REMOTE': '1', 22:48:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:48:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:48:35 INFO - 'NO_EM_RESTART': '1', 22:48:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:48:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:48:35 INFO - 'PWD': '/builds/slave/test', 22:48:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:48:35 INFO - 'SHELL': '/bin/bash', 22:48:35 INFO - 'SHLVL': '1', 22:48:35 INFO - 'TERM': 'linux', 22:48:35 INFO - 'TMOUT': '86400', 22:48:35 INFO - 'USER': 'cltbld', 22:48:35 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1447913990.296135-670975499', 22:48:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:48:35 INFO - '_': '/tools/buildbot/bin/python'} 22:48:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GSTTXjJ6QiC_BQssQfh9Gw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost'] with output_timeout 3600 22:48:35 INFO - mozversion INFO | application_buildid: 20151118222155 22:48:35 INFO - mozversion INFO | application_changeset: 3423dce2511e154845d5c8dd098e63d6bb0a516a 22:48:35 INFO - mozversion INFO | application_display_name: Nightly 22:48:35 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:48:35 INFO - mozversion INFO | application_name: Firefox 22:48:35 INFO - mozversion INFO | application_remotingname: firefox 22:48:35 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 22:48:35 INFO - mozversion INFO | application_vendor: Mozilla 22:48:35 INFO - mozversion INFO | application_version: 45.0a1 22:48:35 INFO - mozversion INFO | platform_buildid: 20151118222155 22:48:35 INFO - mozversion INFO | platform_changeset: 3423dce2511e154845d5c8dd098e63d6bb0a516a 22:48:35 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 22:48:35 INFO - mozversion INFO | platform_version: 45.0a1 22:48:35 INFO - 2015-11-18 22:48:35,886 DEBUG : using testdate: 1447915715 22:48:35 INFO - 2015-11-18 22:48:35,886 DEBUG : actual date: 1447915715 22:48:35 INFO - 2015-11-18 22:48:35,893 INFO : starting webserver on 'localhost:37950' 22:48:35 INFO - 2015-11-18 22:48:35,894 INFO : Starting test suite talos-linux64-ix-036.e 22:48:35 INFO - 2015-11-18 22:48:35,894 INFO : Starting test dromaeo_css 22:48:35 INFO - 2015-11-18 22:48:35,894 DEBUG : operating with platform_type : linux_ 22:48:35 INFO - 2015-11-18 22:48:35,894 INFO : Initialising browser for dromaeo_css test... 22:48:35 INFO - 2015-11-18 22:48:35,901 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp32Q8yf/profile http://localhost:37950/getInfo.html 22:48:43 INFO - 2015-11-18 22:48:43,516 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:48:43 INFO - 2015-11-18 22:48:43,516 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:48:43 INFO - 2015-11-18 22:48:43,517 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:48:43 INFO - 2015-11-18 22:48:43,517 DEBUG : BROWSER_OUTPUT: __metrics 22:48:44 INFO - 2015-11-18 22:48:44,681 INFO : Browser initialized. 22:48:44 INFO - 2015-11-18 22:48:44,682 INFO : Running cycle 1/1 for dromaeo_css test... 22:48:44 INFO - 2015-11-18 22:48:44,682 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp32Q8yf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:48:56 INFO - 2015-11-18 22:48:56,665 DEBUG : BROWSER_OUTPUT: RSS: Main: 141787136 22:48:56 INFO - 2015-11-18 22:48:56,665 DEBUG : BROWSER_OUTPUT: 22:49:46 INFO - 2015-11-18 22:49:46,336 DEBUG : BROWSER_OUTPUT: 1447915786331 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:51:57 INFO - 2015-11-18 22:51:57,767 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37950/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37950/tests/dromaeo/cssquery-ext.html) 22:51:58 INFO - 2015-11-18 22:51:58,735 DEBUG : BROWSER_OUTPUT: RSS: Main: 144957440 22:51:58 INFO - 2015-11-18 22:51:58,736 DEBUG : BROWSER_OUTPUT: 22:55:00 INFO - 2015-11-18 22:55:00,717 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37950/tests/dromaeo/cssquery-ext.html (next: http://localhost:37950/tests/dromaeo/cssquery-jquery.html) 22:55:01 INFO - 2015-11-18 22:55:01,304 DEBUG : BROWSER_OUTPUT: RSS: Main: 144265216 22:55:01 INFO - 2015-11-18 22:55:01,304 DEBUG : BROWSER_OUTPUT: 22:58:03 INFO - 2015-11-18 22:58:03,029 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37950/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37950/tests/dromaeo/cssquery-mootools.html) 22:58:03 INFO - 2015-11-18 22:58:03,622 DEBUG : BROWSER_OUTPUT: RSS: Main: 141905920 22:58:03 INFO - 2015-11-18 22:58:03,622 DEBUG : BROWSER_OUTPUT: 23:01:05 INFO - 2015-11-18 23:01:05,378 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37950/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37950/tests/dromaeo/cssquery-prototype.html) 23:01:05 INFO - 2015-11-18 23:01:05,979 DEBUG : BROWSER_OUTPUT: RSS: Main: 140988416 23:01:05 INFO - 2015-11-18 23:01:05,979 DEBUG : BROWSER_OUTPUT: 23:04:08 INFO - 2015-11-18 23:04:08,564 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37950/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37950/tests/dromaeo/cssquery-yui.html) 23:04:09 INFO - 2015-11-18 23:04:09,177 DEBUG : BROWSER_OUTPUT: RSS: Main: 140984320 23:04:09 INFO - 2015-11-18 23:04:09,177 DEBUG : BROWSER_OUTPUT: 23:07:11 INFO - 2015-11-18 23:07:11,454 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37950/tests/dromaeo/cssquery-yui.html (next: http://localhost:37950/tests/dromaeo/cssquery-dojo.html) 23:07:11 INFO - 2015-11-18 23:07:11,705 DEBUG : BROWSER_OUTPUT: RSS: Main: 143753216 23:07:11 INFO - 2015-11-18 23:07:11,705 DEBUG : BROWSER_OUTPUT: 23:07:11 INFO - 2015-11-18 23:07:11,707 DEBUG : BROWSER_OUTPUT: __start_tp_report 23:07:11 INFO - 2015-11-18 23:07:11,707 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 23:07:11 INFO - 2015-11-18 23:07:11,707 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 23:07:11 INFO - 2015-11-18 23:07:11,707 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 23:07:11 INFO - 2015-11-18 23:07:11,711 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2702.581099929511;2739.2877851758535;2781.249062753057;2789.9442011159763;2805.060304797892;4525.117602067598;4689.695169813964;4750.643701722372;4818.831340903069;4821.27680847873;4536;4561.657875659323;4678.345031695557;4800.9519904800945;4816.301636262749;4254.723442976205;4348.130373925228;4375.124975004996;4404.361367601696;4431.335299705054;4299.699021068526;4365.912681746363;4378.058717375764;4456.844010459635;4529.00361920377;4097.713160078795;4202.915941681149;4429.601335879786;4430.822767089313;4479.888002799939;4278.893027674302;4374.912501749979;4377.584129507723;4395.428594282755;4401.515833258339;4265.573442655741;4304.634106100985;4358.953851075719;4382.320740285261;4404.207242696313;4389.9464128609225;4562.634989200889;4645.117427688729;4665.766711664403;4730.62155027597;5133.871653208662;5143.897122057538;5146.897062058775;5161.535461808456;5161.922571161435;5142.665726727788;5179.637425380225;5181.937702770923;5185;5221.2951251580935;4463.174312752151;4597.402337696078;4633.096546173531;4707.670463067621;4760.500147484534;5187.63686541946;5191.9480805192225;5193;5213.52801697242;5226.790928362899;4997.90004199914;4999.3000979862845;5004.099262132851;5004.249362595567;5017.197248440232;4705.6000239979985;4890.877728056827;4972.801087956514;5053.216751403538;5111.539961403417;5106.4893510648635;5144.8713782155;5148.394307726022;5152.9742351288005;5192.714400707997;4804.183288840905;5092.465291144451;5105.055564720538;5121.667091639106;5124.897502049938;4106.77412742302;4174.352975288835;4178.791060447026;4183.205191013698;4224.5353011168745;3748.9437658435145;3762.473253744478;3772.7359084863797;3782.659560639501;3802.125511132455;4221.387898754725;4320.243957307459;4442.666799989949;4455.353973673799;4458.08609235106;5025.597952163818;5104.132297509433;5117.744112794346;5118.334616499831;5136.409312928986;4365.694401391872;4383.211022016004;4415.094905544356;4420.624246938982;4471.3516540102155;4339.7613131278085;4402.537733537996;4464.799084041161;4548.067646132535;4554.908901821945;4869.853904382874;4879.4876537963;4903.190973489405;4909.1654418748185;4935.481774413778;5131.56381707559;5132.5124113209185;5134.255532947627;5134.306868572695;5151.098557752303;4599.310103484504;4730.858074257778;4793.304970779287;4914.041761856403;4917.852464426073;4982.975085124551;4984.651074424755;4987.650864439454;5016.247562865599;5045.520675535819;5077.466865979167;5079.644424890223;5082.161443361804;5088.59291256706;5115.002574498086;4753.500882407436;4880.585150262267;4885.560299573055;4966.279889416087;4966.304717339503;4943.752812359439;5000.374953130859;5008.824691135793;5027.7234752087525;5062.873428164326;4575.428071491064;4914.533119353656;4917.385326834145;4926.5073492650445;4939.876503087452;4860.392450943632;4867;4930.989147224882;4944.035912996931;4980.626453016111;4888.2911977762315;4893.266010098514;4910.21436570147;4921.704697718148;4939.53074457926 23:07:11 INFO - 2015-11-18 23:07:11,711 DEBUG : BROWSER_OUTPUT: |1;ext.html;562.828337357106;570.7089384413949;570.9714514274287;581.8894410062088;628.0986783965008;37080.25839483209;37513.624863751356;37527.81236093816;37581.812090939544;37726;38082.619173808256;38726.225475490544;38752;38757.22485550287;38836.41745373815;7784.416168787336;7901.367890568741;7965.840683186333;7969.9203007970045;7973.521588704696;7693.49992250502;7843.686252549891;7852.254035866584;7852.450328476981;7854.410919181056;7780.260875216845;7830.373570114406;7864.685412583518;7877.881831772528;7894.881576776353;7565.508241964255;7575.924240757577;7593.886091708629;7594.620268986556;7605.239476052406;7688.769336919901;7836.216378362175;7852.725154619618;7870.645820938014;7887.763367098996;35670.28659426797;36063;36089;36098.81950590257;36195.81902090499;2810.8594570271607;2924.268932766808;3064.4637188491924;3310.6854848789567;3521.996231074157;27546.86226568854;27731.86134069317;27869.86065069682;28168.436631267465;28221.153365398866;2923.3276346440225;2947.277916910349;2979.7318241358166;3013.9397212055856;3064.6475655299705;214036;215446;215539;216362.91818540965;216610;37877.81061094677;39152.80423597864;51335.74332128315;51542.22686659703;51630.741846290526;56580.43419565834;56706;57079;57165;57404.71297643485;11290.604828831116;11352.602658906899;11373.658790236306;11380.601678941362;11457.942710286396;8921.821563568823;8934.776630584287;8982.910170898207;8989;9012.233960113334;17529.860559063876;17823.643527129385;17959.73060404095;17973.550661233574;18004.45986620377;7040.577565346096;7315.626573098898;7348.889766653505;7406.222346653523;7426.405887528985;823.8887750153652;917.7934964632905;919.2829592917535;933.7478880702172;977.9119879210763;26421.603675944876;26435.339116522242;27822.721772782417;28332.858335708603;29034.709652903624;897.537768049455;902.7923577577194;914.433051508056;926.6941909169958;961.3510880155867;12907.419166137546;13080;13108.410121544553;14470.855291447162;14968.02707823988;254435;256260;256518;257436;257712;46609.766951165024;46656.7667161662;46807;46852.297215541796;46910.765446172554;1128.238439053652;1131.4003578103618;1132.5639628742829;1134.2570616246371;1135.0182092490102;26007.60988585135;26340;26434.07480738165;26448.338791530365;26611.86694066517;42951.785241073594;43338.13323733571;43412;43680;43768.562314376446;213203;215884;216144;216407;217459;28390;29059.7094029057;29125.7087429123;29411.11766647004;29589.704102959557;33453;33601;33648;34414.82792586021;34489.65510344865;29267.414651706422;29423.26441838971;29729;29783.404331913673;30412.806655300876;31546;31584.519350811486;32002.67997319997;32171.51742723908;32306;30058;30123;30192.5471117929;30475.085747427613;30492.542611860397;26433;27003.86498067497;28385.85807071034;28784.409403153815;28930.566041508973;21768.782312176674;22847.200347987742;23257.18599848997;23477;23650.29049128529 23:07:11 INFO - 2015-11-18 23:07:11,714 DEBUG : BROWSER_OUTPUT: |2;jquery.html;303.75395929297264;307.1767662664061;311.3446195757928;313.08422863125355;315.9889403870864;10525.894741052587;10811.189160812932;14854.628634284149;15340.923295383522;15625.218739063044;9837.065478779505;9885.555150018266;10060.597576096965;10282.434466104361;10305.690829275134;4079.6940229482757;4152.6055024772595;4167.520735115455;4170.249355116078;4198.496180458349;3067.2945222598814;4070.0028493019254;4182.435371224876;4232.74603523788;4234.87295381139;3148.6536480987074;3222.9838850805713;4146;4178.059936514291;4465.129299786543;4495.617872480843;4537.931931021054;4556.111558246143;4559.954400456003;4563.680542362036;3648.343298206348;3894;3908;3909.4526766252748;3927.0182454386404;11546.307221566733;11996.760064798742;12007;12020.699482513008;12059.819102713467;1715.202430869639;1761.4539492757285;1801.702719051355;1816.9273229070955;1843.0324079858049;8680.78298042554;8734.432261903019;8746.125387461203;8982.640694372218;9008.504532250723;1576.637373404112;1604.8525304407287;1614.2009705195885;1627.8128015278276;1633.8284480129535;51169.74415127938;52281.215781763305;52350.73824630852;52568.73715631474;53150.734246328524;5969.164316995624;6060.515158787286;6074.119252708332;6108.17539632144;6137.1101190328045;7162.856742865113;7179.89230161548;7184.640767961581;7188.5327453715345;7204.567725936356;4651.116287905287;4667.323238130452;4675.2052151134385;4710.317004034396;4721.551452611996;4704.835330763407;4721.716696998191;4725.220338644154;4756;4760.309755085494;2794.1477849255766;2795.4968105740754;2795.664520257582;2804.5232310507263;2819.7603203727504;997.5311603546321;1002.04304888831;1010.3533738407425;1010.6412223660642;1068.8557044799009;374.1469449654791;383.4688955796187;409.86064737989227;412.7853516171574;428.35532523551854;9257.629694812267;10546.630867919586;10581.682549523526;10896.836547451794;11102.555897764161;406.67872380818824;408.57100044953273;412.08517092055587;415.2318211309054;415.87523742877016;5761.48146666802;5889.499392551681;5968.9701551492835;5972.58191926561;6043.002904520793;426370;426508;428888;429214;435922;64920;65292.67353663201;65411.672941634984;66487.33512664908;67149;457.53103069354177;458.3605869811661;459.3018611710182;462.3180808307786;469.9600533954584;9341.532923353941;9472.147506724428;9486.484871422048;9590.952045239728;9618.807623847624;31176.844115780183;31312.686873130977;31517.842410787798;31984;32236.516452252767;39787.40318895277;40982.79508602438;42631.36052959146;43038.139237215706;43141.784291078344;5753.8561535961935;5786.508146807569;5854.209681693087;5857.619254748598;5860.794872179454;9936.602535898772;10391.064804167661;10424.947875260576;10480.423576703355;10481.475926203811;9019.639214431349;9276.16514513697;9518.857217141609;9559.330846840932;9642.855357169788;8774.692885748967;8967.327450441113;9115.453072815651;9174.724758257264;9523.476208808583;9396.389234699722;9410.670626528312;9600.32797704154;9717.514124293899;9750.952300017076;5757.8560535986935;6081.179040829431;6093.969530152321;6106.542009349406;6111.908321375272;9624.615015399306;9649.131578158;9704.126628603177;9821.5089245536;9870.802583948425 23:07:11 INFO - 2015-11-18 23:07:11,716 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1486;1572.3427407681017;1615;1639.7540368944656;1653.2395098254806;6540.182477190351;6597.571157874735;6634.402903738663;6770.729170833167;6894.13823272091;6896.1724593048775;6902.413294869942;6972.96513517433;6977.965110174455;6979;1966.5280332720115;1992.1931617694784;1995.092233033966;2014.1943222710886;2017.384697667211;1937.3897222374978;1961.1959096770327;1966.0464674632792;1985.662437385648;1997.560536681935;1938.8933608651519;1942.2522328903403;1946.9221231150736;1980.8514361422879;1992.6612475879135;1841.9079046047711;1859.2098358197711;1860.9720854187199;1862.9534261643432;1867.8038805925319;1907.9618407631908;1939.5732938753451;1942.2522328903474;1943.4266891266968;1944.4263942137104;6793.45652347811;6871.415929645986;6873.965630171867;6878.55289406187;6899.517033807636;3916.2559113768293;4016.4577781999346;4018.8593399230886;4024.517057953035;4030.052937559671;2652.655154829879;2717.1033558925506;2757.3933734578563;2817.0985284708695;2827.618271533358;856.8586183279814;1689.5438231677379;1731.0825262610836;1735.2364959417816;1737.218251786701;8897.065808090187;8986.415882967522;8995.235404990584;9009.459432434009;9045.638174473013;3469.7224222062173;3489.685928266468;3500.684938355509;3522.788632682047;3529.7529172957647;7448.5158464699625;7475.177730449646;7492.213317601573;7495.138059123271;7513.812154696177;3878.4764056852528;3918.0204948762807;3931.056546428894;3945.368741001426;3947;3603.2973570154095;3622.112582417272;3631.618680038611;3646.781193128421;3656.689181419556;2882.1641723899834;2898.3044069423186;2899.9275018124295;2922.6200593922654;2929.1359049080575;862.7490139298043;867.531532972188;870.7692461497708;871.4727589808201;871.664409202449;749.8612756640039;802.9601665842748;874.5583480342386;931.6971984105193;1149.40231079838;6243.157173781481;6410.1987251593555;6480.805575832733;6480.837979050467;6484.708188131545;592.2123575644468;604.6432604763123;636.1793286660156;639.7089324357406;724.2865777209445;4627.3521706961055;4684.859454216379;4727.361806156194;4760.738159401266;4760.904781904343;7950.403719721044;8125.390595705346;8139.674413023531;8161.959190204011;8167.224113709188;7999.120096789348;8002.359811215205;8050.396220283385;8065.7176998805935;8076.313513351431;6408.038794180817;6412.422881940741;6455.61266324022;6468.3855033771715;6480.449161821204;6177.96911015442;6212.534059945432;6219.875602488016;6222.408871157233;6259.593126446766;7034.824129396806;7233.529820561646;7267.127944646676;7280.817979550342;7298.087739032621;7216.639168041682;7438.6652600632015;7479.850402991801;7483.176850546327;7493.613681468945;5621.662700237999;5628.74670639814;5643.322801263875;5654.886902261849;5678.914816277842;6500;6551.148350714568;6567.474602031922;6569.277379488157;6570.8357291068105;5956.374580668968;6052.364501727256;6066.4540191382985;6160.322364539987;6269.153664255449;5927.940720592911;5983.341832398346;6228.22147231596;6261.499080073492;6338.778142764981;6141.170941922784;6224.844378890564;6262.373762623702;6275.435210831047;6275.6862156892885;5850.12248162779;5880.500157486662;5896.115582662464;5924.851878703067;5940.970295148497;5948.97025514887;5949.881002380015;5963.940360596339;5973.193618861398;5991.610545314715 23:07:11 INFO - 2015-11-18 23:07:11,717 DEBUG : BROWSER_OUTPUT: |4;prototype.html;272.1508892256161;274.51685034339556;279.370020603539;281.41465751237416;281.66763219401105;5559.527440167585;5591.692456914868;5608.186812912125;5658.151277308406;5722.055860782976;5520.089185284433;5557.249771280876;5570.470805273502;5580.665160090397;5588.6646801191955;4162.604552567509;4168.916621667565;4175.979120104411;4178.394132850734;4182.351735481006;4148.149629325996;4170.39529268256;4170.70805043647;4177.373393990895;4183.163367326531;3981.0644498542965;4087.509498860141;4090.5704900985415;4128.091819799654;4130.5043394792665;4046.6964977626794;4072.6538244249273;4081.3061779497407;4086.2236175126777;4114.917701645951;3505.9482155353294;3507.719382449398;3508.1054331145397;3511.1924257420683;3516.4197907345256;5361.705106219157;5369.838904832861;5374.005808925362;5378.46215378463;5385.030694474993;4628.606568441686;4749.050189961987;4751.3348131261655;4758.1673207188605;4760.857174284777;5697.829065128053;5791.82624521265;5837.532997360201;5837.978353788112;5853.209816674737;3806.695464362844;3842.4428457873732;3847.576766555677;3853.9421908671393;3854.2676891390824;6003.429674180989;6129.957907155795;6151.2618485781995;6161.907571386388;6162.075688646694;3801.4867992820614;3903.277893589695;3936.389859571771;3941.4087886817206;3958.604139586076;4005.619466150711;4007.8396864125693;4012.9398059029136;4016.196760647824;4034.0923292259595;4698.765061746899;4709.67032307742;4736.550027747358;4736.976315118472;4744.786484608201;5864.266966629171;5880.8235752927485;5884.58807883444;5886.117082437669;5886.793962211302;1373.7527245095978;1380.7169530246276;1395.6789938314243;1402.4250057476386;1414.5473448496382;913.1872633356318;921.2629896083241;924.4314746430897;931.5621657820949;932.3147486597345;4985.750712464434;5042.520960508746;5049.2426136079885;5083.466236045236;5084.949150508522;5960.225170727777;6002.879942401128;6012.398760123952;6015.909761353583;6020.157177995085;4986.750662466862;5061.31672224245;5069.417017043013;5072.416672082758;5076.0863044652315;3208.374366998413;3219.3078488124697;3278.7213086887405;3298.9175270618425;3303.752218583568;5765.07758758605;5766.769329226784;5773.884522309614;5847.298324201123;5852.122181672783;6360.968195159087;6361.650109243943;6362.586431881913;6366.076918846834;6371.044343348535;5686;5757.078867381283;5839.678817665069;5841.7371218295275;5848.912266316009;6140.5394595406415;6143.84640383994;6162.784302549389;6164.4143806338325;6169.691515424301;5988.490978266722;6015.729292181775;6016.037434010537;6017.338092809875;6022.638641681513;5785.450382213683;5807.012807822764;5813.331466881363;5819.359870414336;5830.591858569859;3881.7865017424315;3941.8029098544384;3986.980065099656;3998.7600743955454;4000.419939108871;5980.5514586405325;6149.84625384369;6154.876902462015;6157.53818463626;6158.661273629993;5858.384869588802;5860.38465961085;5875;5892.499137573354;5909.8227053188475;5826.329972053099;5830.708464576839;5838.591298609226;5844.386339434468;5857.414258574279;5645.842602266608;5717.514011308919;5717.799877004285;5758.107493338539;5763;5864.237649105589;5921.259842519685;5923.703814809156;5928.822135335947;5932.080527518242;5699.316082070178;5726.398728133486;5735.283089613798;5742.3109226891365;5746.42535746422 23:07:11 INFO - 2015-11-18 23:07:11,721 DEBUG : BROWSER_OUTPUT: |5;yui.html;646.0890144895698;763.2062654838971;764.4037650632507;778.3500776851329;783.185487093423;11626.825597616042;11836.822447663271;11857.644270671894;11861.406929653525;11865.288082715033;11667.883321166786;11749.647510574676;11899.167058305922;11950.103742219324;12011.159218854684;756.3457609168086;781.6834182156222;784.047382430347;794.5431376958243;795.5664163031133;745.8769303064988;772.5557804262544;779.3726050529322;781.1680560203393;783.8706613408781;809.8137428391474;814.914433984432;816.0411516468156;816.5141740664325;817.1542453560565;805.9516429014249;807.2129673568282;811.6023148657144;814.9633266503022;816.102287483769;591.4676790888192;592.943670351316;593.2199158107076;594.0969726016474;595.1905408644241;12069.456874440672;12245.448954797055;12300.446479908425;12311.384430778426;12344;8631.827363452696;9278.164965153168;9444.386114902578;9602.08780165883;9664.565094570691;8382.329413646894;8824.205821476035;9001.819963600758;9055.139761722627;9143.771405714844;2972.078655616744;2990.386970671029;3002.594649722303;3014.804037737562;3078.245829771698;38623.42064869029;38650.613493864985;38778.61221387778;38860.805695971336;39313;6941.30586941312;6957.61733104674;7059.329363710439;7093.051572727084;7141.892871606826;10507.159427245955;10530;10539.789204215873;10550.419726914939;10574.101201397967;5602.859928501739;5684.175794509773;5689.68706721126;5717.3996730342715;5895.41045895407;3512.8946131616094;3528.770629909048;3538.168530395355;3546.0957455848593;3673.9632603674154;2280.9771902280763;2295.632698768189;2296.8851557422063;2298.287530865437;2304.2396009316885;432.8398492557774;444.7842796243819;448.03895643844425;448.22233425007585;459.51521145192146;463.3536216977298;521.7026295011807;545.6535100211395;613.9815805525841;627.5387590121258;7874.72438464651;7997.120316765151;7999.720009799629;8117.228863258099;8143.226393492609;443.62513675943774;466.0818188169301;492.849680847345;579.1660009586183;651.3681728723226;3655.469956856241;3805.4291856221234;3851.6340947609933;3853.2678791029616;3892.824822882977;50550;51054.744726276134;51306.48693513092;51517;52005.7399712999;45950.5404945953;46088.769556152;47149.76425117852;47859.28211076836;48894.75552622214;41431.79284103621;41515.377269340985;41562.792186038874;41929.58070419318;42390.57609423866;8179.83640327202;8216.383771217303;8554.230119289294;8611.354148439017;8742.91257087421;30793.076207713806;30887.382252355277;31320.68679313269;31949.840250798596;32194.517082244252;36407.45388819223;36870.44694329641;37010;41185;41504.377434337905;7104.3961263293195;7323.780286591411;7410.848067126118;7443.404527637667;7608.429367797326;11209.831852522382;11363.602273920373;11551.942240288745;11562.768744624893;11615.825762613398;10235.181185505291;10304.742381440225;10510;10877.238593298393;10885.23803333759;10563.63027294041;10806.891931080589;10823.134149268197;10919.126469882549;11245.493952772309;9450.574724137292;9892.950535247277;10846.511906964048;10864.076553493042;10963.287386319864;9079.59141838632;9146.95426522863;9342.252619790537;9485.430874147572;9744.707658770249;8432.53621050848;8732.476051436934;9019.774505637411;9076.455412675261;9291.303152263472 23:07:11 INFO - 2015-11-18 23:07:11,721 DEBUG : BROWSER_OUTPUT: __end_tp_report 23:07:11 INFO - 2015-11-18 23:07:11,721 DEBUG : BROWSER_OUTPUT: __start_cc_report 23:07:11 INFO - 2015-11-18 23:07:11,721 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,296 23:07:11 INFO - 2015-11-18 23:07:11,722 DEBUG : BROWSER_OUTPUT: __end_cc_report 23:07:11 INFO - 2015-11-18 23:07:11,722 DEBUG : BROWSER_OUTPUT: __startTimestamp1447916831706__endTimestamp 23:07:11 INFO - 2015-11-18 23:07:11,722 DEBUG : BROWSER_OUTPUT: 23:07:11 INFO - 2015-11-18 23:07:11,722 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 23:07:11 INFO - 2015-11-18 23:07:11,723 DEBUG : BROWSER_OUTPUT: Number of tests: 6 23:07:11 INFO - 2015-11-18 23:07:11,723 DEBUG : BROWSER_OUTPUT: 23:07:11 INFO - 2015-11-18 23:07:11,723 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4687.44 Median:4860.39 stddev:492.64 (10.1%) stddev-sans-first:468.89 23:07:11 INFO - 2015-11-18 23:07:11,723 DEBUG : BROWSER_OUTPUT: Values: 2702.6 2739.3 2781.2 2789.9 2805.1 4525.1 4689.7 4750.6 4818.8 4821.3 4536.0 4561.7 4678.3 4801.0 4816.3 4254.7 4348.1 4375.1 4404.4 4431.3 4299.7 4365.9 4378.1 4456.8 4529.0 4097.7 4202.9 4429.6 4430.8 4479.9 4278.9 4374.9 4377.6 4395.4 4401.5 4265.6 4304.6 4359.0 4382.3 4404.2 4389.9 4562.6 4645.1 4665.8 4730.6 5133.9 5143.9 5146.9 5161.5 5161.9 5142.7 5179.6 5181.9 5185.0 5221.3 4463.2 4597.4 4633.1 4707.7 4760.5 5187.6 5191.9 5193.0 5213.5 5226.8 4997.9 4999.3 5004.1 5004.2 5017.2 4705.6 4890.9 4972.8 5053.2 5111.5 5106.5 5144.9 5148.4 5153.0 5192.7 4804.2 5092.5 5105.1 5121.7 5124.9 4106.8 4174.4 4178.8 4183.2 4224.5 3748.9 3762.5 3772.7 3782.7 3802.1 4221.4 4320.2 4442.7 4455.4 4458.1 5025.6 5104.1 5117.7 5118.3 5136.4 4365.7 4383.2 4415.1 4420.6 4471.4 4339.8 4402.5 4464.8 4548.1 4554.9 4869.9 4879.5 4903.2 4909.2 4935.5 5131.6 5132.5 5134.3 5134.3 5151.1 4599.3 4730.9 4793.3 4914.0 4917.9 4983.0 4984.7 4987.7 5016.2 5045.5 5077.5 5079.6 5082.2 5088.6 5115.0 4753.5 4880.6 4885.6 4966.3 4966.3 4943.8 5000.4 5008.8 5027.7 5062.9 4575.4 4914.5 4917.4 4926.5 4939.9 4860.4 4867.0 4931.0 4944.0 4980.6 4888.3 4893.3 4910.2 4921.7 4939.5 23:07:11 INFO - 2015-11-18 23:07:11,724 DEBUG : BROWSER_OUTPUT: 23:07:11 INFO - 2015-11-18 23:07:11,724 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:38587.30 Median:33624.50 stddev:59888.83 (178.1%) stddev-sans-first:59988.78 23:07:11 INFO - 2015-11-18 23:07:11,725 DEBUG : BROWSER_OUTPUT: Values: 562.8 570.7 571.0 581.9 628.1 37080.3 37513.6 37527.8 37581.8 37726.0 38082.6 38726.2 38752.0 38757.2 38836.4 7784.4 7901.4 7965.8 7969.9 7973.5 7693.5 7843.7 7852.3 7852.5 7854.4 7780.3 7830.4 7864.7 7877.9 7894.9 7565.5 7575.9 7593.9 7594.6 7605.2 7688.8 7836.2 7852.7 7870.6 7887.8 35670.3 36063.0 36089.0 36098.8 36195.8 2810.9 2924.3 3064.5 3310.7 3522.0 27546.9 27731.9 27869.9 28168.4 28221.2 2923.3 2947.3 2979.7 3013.9 3064.6 214036.0 215446.0 215539.0 216362.9 216610.0 37877.8 39152.8 51335.7 51542.2 51630.7 56580.4 56706.0 57079.0 57165.0 57404.7 11290.6 11352.6 11373.7 11380.6 11457.9 8921.8 8934.8 8982.9 8989.0 9012.2 17529.9 17823.6 17959.7 17973.6 18004.5 7040.6 7315.6 7348.9 7406.2 7426.4 823.9 917.8 919.3 933.7 977.9 26421.6 26435.3 27822.7 28332.9 29034.7 897.5 902.8 914.4 926.7 961.4 12907.4 13080.0 13108.4 14470.9 14968.0 254435.0 256260.0 256518.0 257436.0 257712.0 46609.8 46656.8 46807.0 46852.3 46910.8 1128.2 1131.4 1132.6 1134.3 1135.0 26007.6 26340.0 26434.1 26448.3 26611.9 42951.8 43338.1 43412.0 43680.0 43768.6 213203.0 215884.0 216144.0 216407.0 217459.0 28390.0 29059.7 29125.7 29411.1 29589.7 33453.0 33601.0 33648.0 34414.8 34489.7 29267.4 29423.3 29729.0 29783.4 30412.8 31546.0 31584.5 32002.7 32171.5 32306.0 30058.0 30123.0 30192.5 30475.1 30492.5 26433.0 27003.9 28385.9 28784.4 28930.6 21768.8 22847.2 23257.2 23477.0 23650.3 23:07:11 INFO - 2015-11-18 23:07:11,726 DEBUG : BROWSER_OUTPUT: 23:07:11 INFO - 2015-11-18 23:07:11,726 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:22308.52 Median:4516.77 stddev:70474.69 (1560.3%) stddev-sans-first:70653.02 23:07:11 INFO - 2015-11-18 23:07:11,727 DEBUG : BROWSER_OUTPUT: Values: 303.8 307.2 311.3 313.1 316.0 10525.9 10811.2 14854.6 15340.9 15625.2 9837.1 9885.6 10060.6 10282.4 10305.7 4079.7 4152.6 4167.5 4170.2 4198.5 3067.3 4070.0 4182.4 4232.7 4234.9 3148.7 3223.0 4146.0 4178.1 4465.1 4495.6 4537.9 4556.1 4560.0 4563.7 3648.3 3894.0 3908.0 3909.5 3927.0 11546.3 11996.8 12007.0 12020.7 12059.8 1715.2 1761.5 1801.7 1816.9 1843.0 8680.8 8734.4 8746.1 8982.6 9008.5 1576.6 1604.9 1614.2 1627.8 1633.8 51169.7 52281.2 52350.7 52568.7 53150.7 5969.2 6060.5 6074.1 6108.2 6137.1 7162.9 7179.9 7184.6 7188.5 7204.6 4651.1 4667.3 4675.2 4710.3 4721.6 4704.8 4721.7 4725.2 4756.0 4760.3 2794.1 2795.5 2795.7 2804.5 2819.8 997.5 1002.0 1010.4 1010.6 1068.9 374.1 383.5 409.9 412.8 428.4 9257.6 10546.6 10581.7 10896.8 11102.6 406.7 408.6 412.1 415.2 415.9 5761.5 5889.5 5969.0 5972.6 6043.0 426370.0 426508.0 428888.0 429214.0 435922.0 64920.0 65292.7 65411.7 66487.3 67149.0 457.5 458.4 459.3 462.3 470.0 9341.5 9472.1 9486.5 9591.0 9618.8 31176.8 31312.7 31517.8 31984.0 32236.5 39787.4 40982.8 42631.4 43038.1 43141.8 5753.9 5786.5 5854.2 5857.6 5860.8 9936.6 10391.1 10424.9 10480.4 10481.5 9019.6 9276.2 9518.9 9559.3 9642.9 8774.7 8967.3 9115.5 9174.7 9523.5 9396.4 9410.7 9600.3 9717.5 9751.0 5757.9 6081.2 6094.0 6106.5 6111.9 9624.6 9649.1 9704.1 9821.5 9870.8 23:07:11 INFO - 2015-11-18 23:07:11,728 DEBUG : BROWSER_OUTPUT: 23:07:11 INFO - 2015-11-18 23:07:11,728 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4724.94 Median:6059.41 stddev:2436.30 (40.2%) stddev-sans-first:2430.98 23:07:11 INFO - 2015-11-18 23:07:11,728 DEBUG : BROWSER_OUTPUT: Values: 1486.0 1572.3 1615.0 1639.8 1653.2 6540.2 6597.6 6634.4 6770.7 6894.1 6896.2 6902.4 6973.0 6978.0 6979.0 1966.5 1992.2 1995.1 2014.2 2017.4 1937.4 1961.2 1966.0 1985.7 1997.6 1938.9 1942.3 1946.9 1980.9 1992.7 1841.9 1859.2 1861.0 1863.0 1867.8 1908.0 1939.6 1942.3 1943.4 1944.4 6793.5 6871.4 6874.0 6878.6 6899.5 3916.3 4016.5 4018.9 4024.5 4030.1 2652.7 2717.1 2757.4 2817.1 2827.6 856.9 1689.5 1731.1 1735.2 1737.2 8897.1 8986.4 8995.2 9009.5 9045.6 3469.7 3489.7 3500.7 3522.8 3529.8 7448.5 7475.2 7492.2 7495.1 7513.8 3878.5 3918.0 3931.1 3945.4 3947.0 3603.3 3622.1 3631.6 3646.8 3656.7 2882.2 2898.3 2899.9 2922.6 2929.1 862.7 867.5 870.8 871.5 871.7 749.9 803.0 874.6 931.7 1149.4 6243.2 6410.2 6480.8 6480.8 6484.7 592.2 604.6 636.2 639.7 724.3 4627.4 4684.9 4727.4 4760.7 4760.9 7950.4 8125.4 8139.7 8162.0 8167.2 7999.1 8002.4 8050.4 8065.7 8076.3 6408.0 6412.4 6455.6 6468.4 6480.4 6178.0 6212.5 6219.9 6222.4 6259.6 7034.8 7233.5 7267.1 7280.8 7298.1 7216.6 7438.7 7479.9 7483.2 7493.6 5621.7 5628.7 5643.3 5654.9 5678.9 6500.0 6551.1 6567.5 6569.3 6570.8 5956.4 6052.4 6066.5 6160.3 6269.2 5927.9 5983.3 6228.2 6261.5 6338.8 6141.2 6224.8 6262.4 6275.4 6275.7 5850.1 5880.5 5896.1 5924.9 5941.0 5949.0 5949.9 5963.9 5973.2 5991.6 23:07:11 INFO - 2015-11-18 23:07:11,728 DEBUG : BROWSER_OUTPUT: 23:07:11 INFO - 2015-11-18 23:07:11,729 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4796.54 Median:5590.18 stddev:1483.73 (26.5%) stddev-sans-first:1448.51 23:07:11 INFO - 2015-11-18 23:07:11,730 DEBUG : BROWSER_OUTPUT: Values: 272.2 274.5 279.4 281.4 281.7 5559.5 5591.7 5608.2 5658.2 5722.1 5520.1 5557.2 5570.5 5580.7 5588.7 4162.6 4168.9 4176.0 4178.4 4182.4 4148.1 4170.4 4170.7 4177.4 4183.2 3981.1 4087.5 4090.6 4128.1 4130.5 4046.7 4072.7 4081.3 4086.2 4114.9 3505.9 3507.7 3508.1 3511.2 3516.4 5361.7 5369.8 5374.0 5378.5 5385.0 4628.6 4749.1 4751.3 4758.2 4760.9 5697.8 5791.8 5837.5 5838.0 5853.2 3806.7 3842.4 3847.6 3853.9 3854.3 6003.4 6130.0 6151.3 6161.9 6162.1 3801.5 3903.3 3936.4 3941.4 3958.6 4005.6 4007.8 4012.9 4016.2 4034.1 4698.8 4709.7 4736.6 4737.0 4744.8 5864.3 5880.8 5884.6 5886.1 5886.8 1373.8 1380.7 1395.7 1402.4 1414.5 913.2 921.3 924.4 931.6 932.3 4985.8 5042.5 5049.2 5083.5 5084.9 5960.2 6002.9 6012.4 6015.9 6020.2 4986.8 5061.3 5069.4 5072.4 5076.1 3208.4 3219.3 3278.7 3298.9 3303.8 5765.1 5766.8 5773.9 5847.3 5852.1 6361.0 6361.7 6362.6 6366.1 6371.0 5686.0 5757.1 5839.7 5841.7 5848.9 6140.5 6143.8 6162.8 6164.4 6169.7 5988.5 6015.7 6016.0 6017.3 6022.6 5785.5 5807.0 5813.3 5819.4 5830.6 3881.8 3941.8 3987.0 3998.8 4000.4 5980.6 6149.8 6154.9 6157.5 6158.7 5858.4 5860.4 5875.0 5892.5 5909.8 5826.3 5830.7 5838.6 5844.4 5857.4 5645.8 5717.5 5717.8 5758.1 5763.0 5864.2 5921.3 5923.7 5928.8 5932.1 5699.3 5726.4 5735.3 5742.3 5746.4 23:07:11 INFO - 2015-11-18 23:07:11,730 DEBUG : BROWSER_OUTPUT: 23:07:11 INFO - 2015-11-18 23:07:11,730 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11963.75 Median:24693.80 stddev:14087.83 (57.1%) stddev-sans-first:14101.71 23:07:11 INFO - 2015-11-18 23:07:11,730 DEBUG : BROWSER_OUTPUT: Values: 646.1 763.2 764.4 778.4 783.2 11626.8 11836.8 11857.6 11861.4 11865.3 11667.9 11749.6 11899.2 11950.1 12011.2 756.3 781.7 784.0 794.5 795.6 745.9 772.6 779.4 781.2 783.9 809.8 814.9 816.0 816.5 817.2 806.0 807.2 811.6 815.0 816.1 591.5 592.9 593.2 594.1 595.2 12069.5 12245.4 12300.4 12311.4 12344.0 8631.8 9278.2 9444.4 9602.1 9664.6 8382.3 8824.2 9001.8 9055.1 9143.8 2972.1 2990.4 3002.6 3014.8 3078.2 38623.4 38650.6 38778.6 38860.8 39313.0 6941.3 6957.6 7059.3 7093.1 7141.9 10507.2 10530.0 10539.8 10550.4 10574.1 5602.9 5684.2 5689.7 5717.4 5895.4 3512.9 3528.8 3538.2 3546.1 3674.0 2281.0 2295.6 2296.9 2298.3 2304.2 432.8 444.8 448.0 448.2 459.5 463.4 521.7 545.7 614.0 627.5 7874.7 7997.1 7999.7 8117.2 8143.2 443.6 466.1 492.8 579.2 651.4 3655.5 3805.4 3851.6 3853.3 3892.8 50550.0 51054.7 51306.5 51517.0 52005.7 45950.5 46088.8 47149.8 47859.3 48894.8 41431.8 41515.4 41562.8 41929.6 42390.6 8179.8 8216.4 8554.2 8611.4 8742.9 30793.1 30887.4 31320.7 31949.8 32194.5 36407.5 36870.4 37010.0 41185.0 41504.4 7104.4 7323.8 7410.8 7443.4 7608.4 11209.8 11363.6 11551.9 11562.8 11615.8 10235.2 10304.7 10510.0 10877.2 10885.2 10563.6 10806.9 10823.1 10919.1 11245.5 9450.6 9893.0 10846.5 10864.1 10963.3 9079.6 9147.0 9342.3 9485.4 9744.7 8432.5 8732.5 9019.8 9076.5 9291.3 23:07:11 INFO - 2015-11-18 23:07:11,731 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 23:07:11 INFO - 2015-11-18 23:07:11,731 DEBUG : BROWSER_OUTPUT: 23:07:12 INFO - 2015-11-18 23:07:12,501 INFO : Browser exited with error code: 0 23:07:12 INFO - 2015-11-18 23:07:12,522 INFO : Completed test dromaeo_css (00:18:36) 23:07:12 INFO - 2015-11-18 23:07:12,523 INFO : Starting test kraken 23:07:12 INFO - 2015-11-18 23:07:12,523 DEBUG : operating with platform_type : linux_ 23:07:12 INFO - 2015-11-18 23:07:12,523 INFO : Initialising browser for kraken test... 23:07:12 INFO - 2015-11-18 23:07:12,529 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjt8uQU/profile http://localhost:37950/getInfo.html 23:07:17 INFO - 2015-11-18 23:07:17,937 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 23:07:17 INFO - 2015-11-18 23:07:17,938 DEBUG : BROWSER_OUTPUT: colorDepth:24 23:07:17 INFO - 2015-11-18 23:07:17,938 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 23:07:17 INFO - 2015-11-18 23:07:17,938 DEBUG : BROWSER_OUTPUT: __metrics 23:07:19 INFO - 2015-11-18 23:07:19,153 INFO : Browser initialized. 23:07:19 INFO - 2015-11-18 23:07:19,154 INFO : Running cycle 1/1 for kraken test... 23:07:19 INFO - 2015-11-18 23:07:19,154 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjt8uQU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 23:07:31 INFO - 2015-11-18 23:07:31,110 DEBUG : BROWSER_OUTPUT: RSS: Main: 142020608 23:07:31 INFO - 2015-11-18 23:07:31,110 DEBUG : BROWSER_OUTPUT: 23:07:33 INFO - 2015-11-18 23:07:33,726 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37950/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37950/tests/kraken/driver.html?testName=audio-beat-detection) 23:07:34 INFO - 2015-11-18 23:07:34,332 DEBUG : BROWSER_OUTPUT: RSS: Main: 141287424 23:07:34 INFO - 2015-11-18 23:07:34,333 DEBUG : BROWSER_OUTPUT: 23:07:37 INFO - 2015-11-18 23:07:37,095 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37950/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37950/tests/kraken/driver.html?testName=audio-dft) 23:07:37 INFO - 2015-11-18 23:07:37,697 DEBUG : BROWSER_OUTPUT: RSS: Main: 141332480 23:07:37 INFO - 2015-11-18 23:07:37,697 DEBUG : BROWSER_OUTPUT: 23:07:40 INFO - 2015-11-18 23:07:40,602 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37950/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37950/tests/kraken/driver.html?testName=audio-fft) 23:07:41 INFO - 2015-11-18 23:07:41,188 DEBUG : BROWSER_OUTPUT: RSS: Main: 137605120 23:07:41 INFO - 2015-11-18 23:07:41,188 DEBUG : BROWSER_OUTPUT: 23:07:43 INFO - 2015-11-18 23:07:43,301 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37950/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37950/tests/kraken/driver.html?testName=audio-oscillator) 23:07:43 INFO - 2015-11-18 23:07:43,927 DEBUG : BROWSER_OUTPUT: RSS: Main: 137871360 23:07:43 INFO - 2015-11-18 23:07:43,927 DEBUG : BROWSER_OUTPUT: 23:07:46 INFO - 2015-11-18 23:07:46,210 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37950/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37950/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:07:46 INFO - 2015-11-18 23:07:46,796 DEBUG : BROWSER_OUTPUT: RSS: Main: 138588160 23:07:46 INFO - 2015-11-18 23:07:46,796 DEBUG : BROWSER_OUTPUT: 23:07:49 INFO - 2015-11-18 23:07:49,868 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37950/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37950/tests/kraken/driver.html?testName=imaging-darkroom) 23:07:50 INFO - 2015-11-18 23:07:50,461 DEBUG : BROWSER_OUTPUT: RSS: Main: 137486336 23:07:50 INFO - 2015-11-18 23:07:50,461 DEBUG : BROWSER_OUTPUT: 23:07:53 INFO - 2015-11-18 23:07:53,964 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37950/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37950/tests/kraken/driver.html?testName=imaging-desaturate) 23:07:54 INFO - 2015-11-18 23:07:54,557 DEBUG : BROWSER_OUTPUT: RSS: Main: 136220672 23:07:54 INFO - 2015-11-18 23:07:54,557 DEBUG : BROWSER_OUTPUT: 23:07:57 INFO - 2015-11-18 23:07:57,436 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37950/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37950/tests/kraken/driver.html?testName=json-parse-financial) 23:07:58 INFO - 2015-11-18 23:07:58,037 DEBUG : BROWSER_OUTPUT: RSS: Main: 136773632 23:07:58 INFO - 2015-11-18 23:07:58,037 DEBUG : BROWSER_OUTPUT: 23:07:59 INFO - 2015-11-18 23:07:59,829 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37950/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37950/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:08:00 INFO - 2015-11-18 23:08:00,411 DEBUG : BROWSER_OUTPUT: RSS: Main: 139042816 23:08:00 INFO - 2015-11-18 23:08:00,411 DEBUG : BROWSER_OUTPUT: 23:08:02 INFO - 2015-11-18 23:08:02,301 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37950/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37950/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:08:02 INFO - 2015-11-18 23:08:02,915 DEBUG : BROWSER_OUTPUT: RSS: Main: 138600448 23:08:02 INFO - 2015-11-18 23:08:02,915 DEBUG : BROWSER_OUTPUT: 23:08:05 INFO - 2015-11-18 23:08:05,134 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37950/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37950/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:08:05 INFO - 2015-11-18 23:08:05,735 DEBUG : BROWSER_OUTPUT: RSS: Main: 138035200 23:08:05 INFO - 2015-11-18 23:08:05,736 DEBUG : BROWSER_OUTPUT: 23:08:08 INFO - 2015-11-18 23:08:08,351 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37950/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37950/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:08:08 INFO - 2015-11-18 23:08:08,957 DEBUG : BROWSER_OUTPUT: RSS: Main: 137912320 23:08:08 INFO - 2015-11-18 23:08:08,957 DEBUG : BROWSER_OUTPUT: 23:08:11 INFO - 2015-11-18 23:08:11,618 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37950/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37950/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:08:12 INFO - 2015-11-18 23:08:12,219 DEBUG : BROWSER_OUTPUT: RSS: Main: 139284480 23:08:12 INFO - 2015-11-18 23:08:12,220 DEBUG : BROWSER_OUTPUT: 23:08:13 INFO - 2015-11-18 23:08:13,995 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37950/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37950/tests/kraken/driver.html?testName=ai-astar) 23:08:14 INFO - 2015-11-18 23:08:14,245 DEBUG : BROWSER_OUTPUT: RSS: Main: 139419648 23:08:14 INFO - 2015-11-18 23:08:14,245 DEBUG : BROWSER_OUTPUT: 23:08:14 INFO - 2015-11-18 23:08:14,247 DEBUG : BROWSER_OUTPUT: __start_tp_report 23:08:14 INFO - 2015-11-18 23:08:14,247 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 23:08:14 INFO - 2015-11-18 23:08:14,247 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 23:08:14 INFO - 2015-11-18 23:08:14,248 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 23:08:14 INFO - 2015-11-18 23:08:14,248 DEBUG : BROWSER_OUTPUT: |0;ai-astar;117;109;116;114;116;128;114;115;113;116 23:08:14 INFO - 2015-11-18 23:08:14,248 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;156;133;155;168;144;162;156;134;168;143 23:08:14 INFO - 2015-11-18 23:08:14,248 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;164;165;164;163;165;168;161;165;164 23:08:14 INFO - 2015-11-18 23:08:14,249 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;72;73;73;85;73;148;73;74;74 23:08:14 INFO - 2015-11-18 23:08:14,249 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;92;136;93;92;92;133;92;93;134 23:08:14 INFO - 2015-11-18 23:08:14,249 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;111;111;111;110;110;110;110;110;115 23:08:14 INFO - 2015-11-18 23:08:14,249 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;149;149;149;149;149;149;149;150;150;150 23:08:14 INFO - 2015-11-18 23:08:14,250 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;99;96;96;101;100;98;97;96;97 23:08:14 INFO - 2015-11-18 23:08:14,250 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;75;74;75;75;77;76;77;80;77;72 23:08:14 INFO - 2015-11-18 23:08:14,250 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;70;70;70;70;71;70;69;70;69 23:08:14 INFO - 2015-11-18 23:08:14,251 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;91;84;87;84;88;85;94;97;86;86 23:08:14 INFO - 2015-11-18 23:08:14,251 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;122;151;139;124;127;129;129;134;128;122 23:08:14 INFO - 2015-11-18 23:08:14,251 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;144;154;155;157;160;159;155;158;156;142 23:08:14 INFO - 2015-11-18 23:08:14,251 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;71;74;76;73;73;71;71;71;72 23:08:14 INFO - 2015-11-18 23:08:14,251 DEBUG : BROWSER_OUTPUT: __end_tp_report 23:08:14 INFO - 2015-11-18 23:08:14,252 DEBUG : BROWSER_OUTPUT: __start_cc_report 23:08:14 INFO - 2015-11-18 23:08:14,252 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,791 23:08:14 INFO - 2015-11-18 23:08:14,252 DEBUG : BROWSER_OUTPUT: __end_cc_report 23:08:14 INFO - 2015-11-18 23:08:14,252 DEBUG : BROWSER_OUTPUT: __startTimestamp1447916894246__endTimestamp 23:08:14 INFO - 2015-11-18 23:08:14,253 DEBUG : BROWSER_OUTPUT: 23:08:14 INFO - 2015-11-18 23:08:14,256 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 23:08:14 INFO - 2015-11-18 23:08:14,256 DEBUG : BROWSER_OUTPUT: Number of tests: 14 23:08:14 INFO - 2015-11-18 23:08:14,257 DEBUG : BROWSER_OUTPUT: 23:08:14 INFO - 2015-11-18 23:08:14,257 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:115.80 Median:116.00 stddev:4.85 (4.2%) stddev-sans-first:5.12 23:08:14 INFO - 2015-11-18 23:08:14,257 DEBUG : BROWSER_OUTPUT: Values: 117.0 109.0 116.0 114.0 116.0 128.0 114.0 115.0 113.0 116.0 23:08:14 INFO - 2015-11-18 23:08:14,257 DEBUG : BROWSER_OUTPUT: 23:08:14 INFO - 2015-11-18 23:08:14,257 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:151.90 Median:156.00 stddev:12.84 (8.2%) stddev-sans-first:13.53 23:08:14 INFO - 2015-11-18 23:08:14,258 DEBUG : BROWSER_OUTPUT: Values: 156.0 133.0 155.0 168.0 144.0 162.0 156.0 134.0 168.0 143.0 23:08:14 INFO - 2015-11-18 23:08:14,258 DEBUG : BROWSER_OUTPUT: 23:08:14 INFO - 2015-11-18 23:08:14,258 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.20 Median:164.50 stddev:1.81 (1.1%) stddev-sans-first:1.87 23:08:14 INFO - 2015-11-18 23:08:14,258 DEBUG : BROWSER_OUTPUT: Values: 163.0 164.0 165.0 164.0 163.0 165.0 168.0 161.0 165.0 164.0 23:08:14 INFO - 2015-11-18 23:08:14,258 DEBUG : BROWSER_OUTPUT: 23:08:14 INFO - 2015-11-18 23:08:14,258 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.80 Median:73.00 stddev:23.56 (32.3%) stddev-sans-first:24.78 23:08:14 INFO - 2015-11-18 23:08:14,258 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 73.0 73.0 85.0 73.0 148.0 73.0 74.0 74.0 23:08:14 INFO - 2015-11-18 23:08:14,258 DEBUG : BROWSER_OUTPUT: 23:08:14 INFO - 2015-11-18 23:08:14,258 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.90 Median:92.00 stddev:20.33 (22.1%) stddev-sans-first:21.02 23:08:14 INFO - 2015-11-18 23:08:14,259 DEBUG : BROWSER_OUTPUT: Values: 92.0 92.0 136.0 93.0 92.0 92.0 133.0 92.0 93.0 134.0 23:08:14 INFO - 2015-11-18 23:08:14,259 DEBUG : BROWSER_OUTPUT: 23:08:14 INFO - 2015-11-18 23:08:14,259 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.80 Median:110.50 stddev:1.55 (1.4%) stddev-sans-first:1.62 23:08:14 INFO - 2015-11-18 23:08:14,259 DEBUG : BROWSER_OUTPUT: Values: 110.0 111.0 111.0 111.0 110.0 110.0 110.0 110.0 110.0 115.0 23:08:14 INFO - 2015-11-18 23:08:14,259 DEBUG : BROWSER_OUTPUT: 23:08:14 INFO - 2015-11-18 23:08:14,259 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:149.30 Median:149.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 23:08:14 INFO - 2015-11-18 23:08:14,259 DEBUG : BROWSER_OUTPUT: Values: 149.0 149.0 149.0 149.0 149.0 149.0 149.0 150.0 150.0 150.0 23:08:14 INFO - 2015-11-18 23:08:14,259 DEBUG : BROWSER_OUTPUT: 23:08:14 INFO - 2015-11-18 23:08:14,260 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:97.60 Median:96.50 stddev:1.84 (1.9%) stddev-sans-first:1.86 23:08:14 INFO - 2015-11-18 23:08:14,260 DEBUG : BROWSER_OUTPUT: Values: 96.0 99.0 96.0 96.0 101.0 100.0 98.0 97.0 96.0 97.0 23:08:14 INFO - 2015-11-18 23:08:14,260 DEBUG : BROWSER_OUTPUT: 23:08:14 INFO - 2015-11-18 23:08:14,260 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:75.80 Median:76.50 stddev:2.15 (2.8%) stddev-sans-first:2.26 23:08:14 INFO - 2015-11-18 23:08:14,260 DEBUG : BROWSER_OUTPUT: Values: 75.0 74.0 75.0 75.0 77.0 76.0 77.0 80.0 77.0 72.0 23:08:14 INFO - 2015-11-18 23:08:14,260 DEBUG : BROWSER_OUTPUT: 23:08:14 INFO - 2015-11-18 23:08:14,260 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.80 Median:70.00 stddev:0.63 (0.9%) stddev-sans-first:0.60 23:08:14 INFO - 2015-11-18 23:08:14,260 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 70.0 70.0 70.0 71.0 70.0 69.0 70.0 69.0 23:08:14 INFO - 2015-11-18 23:08:14,261 DEBUG : BROWSER_OUTPUT: 23:08:14 INFO - 2015-11-18 23:08:14,261 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:88.20 Median:87.50 stddev:4.42 (5.0%) stddev-sans-first:4.57 23:08:14 INFO - 2015-11-18 23:08:14,261 DEBUG : BROWSER_OUTPUT: Values: 91.0 84.0 87.0 84.0 88.0 85.0 94.0 97.0 86.0 86.0 23:08:14 INFO - 2015-11-18 23:08:14,261 DEBUG : BROWSER_OUTPUT: 23:08:14 INFO - 2015-11-18 23:08:14,261 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:130.50 Median:129.00 stddev:8.91 (6.9%) stddev-sans-first:8.90 23:08:14 INFO - 2015-11-18 23:08:14,261 DEBUG : BROWSER_OUTPUT: Values: 122.0 151.0 139.0 124.0 127.0 129.0 129.0 134.0 128.0 122.0 23:08:14 INFO - 2015-11-18 23:08:14,261 DEBUG : BROWSER_OUTPUT: 23:08:14 INFO - 2015-11-18 23:08:14,262 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.00 Median:156.50 stddev:6.11 (3.9%) stddev-sans-first:5.30 23:08:14 INFO - 2015-11-18 23:08:14,262 DEBUG : BROWSER_OUTPUT: Values: 144.0 154.0 155.0 157.0 160.0 159.0 155.0 158.0 156.0 142.0 23:08:14 INFO - 2015-11-18 23:08:14,262 DEBUG : BROWSER_OUTPUT: 23:08:14 INFO - 2015-11-18 23:08:14,262 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.30 Median:72.50 stddev:1.70 (2.3%) stddev-sans-first:1.74 23:08:14 INFO - 2015-11-18 23:08:14,262 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 74.0 76.0 73.0 73.0 71.0 71.0 71.0 72.0 23:08:14 INFO - 2015-11-18 23:08:14,262 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 23:08:14 INFO - 2015-11-18 23:08:14,262 DEBUG : BROWSER_OUTPUT: 23:08:15 INFO - 2015-11-18 23:08:15,205 INFO : Browser exited with error code: 0 23:08:15 INFO - 2015-11-18 23:08:15,256 INFO : Completed test kraken (00:01:02) 23:08:15 INFO - 2015-11-18 23:08:15,256 INFO : Starting test v8_7 23:08:15 INFO - 2015-11-18 23:08:15,257 DEBUG : operating with platform_type : linux_ 23:08:15 INFO - 2015-11-18 23:08:15,257 INFO : Initialising browser for v8_7 test... 23:08:15 INFO - 2015-11-18 23:08:15,263 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2J6EcS/profile http://localhost:37950/getInfo.html 23:08:20 INFO - 2015-11-18 23:08:20,947 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 23:08:20 INFO - 2015-11-18 23:08:20,947 DEBUG : BROWSER_OUTPUT: colorDepth:24 23:08:20 INFO - 2015-11-18 23:08:20,947 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 23:08:20 INFO - 2015-11-18 23:08:20,947 DEBUG : BROWSER_OUTPUT: __metrics 23:08:22 INFO - 2015-11-18 23:08:22,237 INFO : Browser initialized. 23:08:22 INFO - 2015-11-18 23:08:22,238 INFO : Running cycle 1/1 for v8_7 test... 23:08:22 INFO - 2015-11-18 23:08:22,238 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2J6EcS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 23:08:34 INFO - 2015-11-18 23:08:34,262 DEBUG : BROWSER_OUTPUT: RSS: Main: 141815808 23:08:34 INFO - 2015-11-18 23:08:34,262 DEBUG : BROWSER_OUTPUT: 23:08:55 INFO - 2015-11-18 23:08:55,744 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37950/tests/v8_7/run.html (next: http://localhost:37950/tests/v8_7/run.html) 23:08:56 INFO - 2015-11-18 23:08:56,002 DEBUG : BROWSER_OUTPUT: RSS: Main: 138514432 23:08:56 INFO - 2015-11-18 23:08:56,002 DEBUG : BROWSER_OUTPUT: 23:08:56 INFO - 2015-11-18 23:08:56,002 DEBUG : BROWSER_OUTPUT: __start_tp_report 23:08:56 INFO - 2015-11-18 23:08:56,002 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 23:08:56 INFO - 2015-11-18 23:08:56,002 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 23:08:56 INFO - 2015-11-18 23:08:56,002 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 23:08:56 INFO - 2015-11-18 23:08:56,003 DEBUG : BROWSER_OUTPUT: |0;Richards;166.44474034620507 23:08:56 INFO - 2015-11-18 23:08:56,003 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.68104274487254 23:08:56 INFO - 2015-11-18 23:08:56,003 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.56388034665923 23:08:56 INFO - 2015-11-18 23:08:56,003 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5040.201005025126 23:08:56 INFO - 2015-11-18 23:08:56,003 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1081.081081081081 23:08:56 INFO - 2015-11-18 23:08:56,003 DEBUG : BROWSER_OUTPUT: |5;Earley;715 23:08:56 INFO - 2015-11-18 23:08:56,003 DEBUG : BROWSER_OUTPUT: |6;Boyer;12195.121951219513 23:08:56 INFO - 2015-11-18 23:08:56,004 DEBUG : BROWSER_OUTPUT: |7;RegExp;25897.4358974359 23:08:56 INFO - 2015-11-18 23:08:56,004 DEBUG : BROWSER_OUTPUT: |8;Splay;621.1180124223603 23:08:56 INFO - 2015-11-18 23:08:56,004 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 23:08:56 INFO - 2015-11-18 23:08:56,004 DEBUG : BROWSER_OUTPUT: __end_tp_report 23:08:56 INFO - 2015-11-18 23:08:56,004 DEBUG : BROWSER_OUTPUT: __startTimestamp1447916935996__endTimestamp 23:08:56 INFO - 2015-11-18 23:08:56,004 DEBUG : BROWSER_OUTPUT: 23:08:56 INFO - 2015-11-18 23:08:56,004 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 23:08:56 INFO - 2015-11-18 23:08:56,004 DEBUG : BROWSER_OUTPUT: Number of tests: 10 23:08:56 INFO - 2015-11-18 23:08:56,005 DEBUG : BROWSER_OUTPUT: 23:08:56 INFO - 2015-11-18 23:08:56,005 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.44 Median:166.44 stddev:0.00 (0.0%) 23:08:56 INFO - 2015-11-18 23:08:56,005 DEBUG : BROWSER_OUTPUT: Values: 166.4 23:08:56 INFO - 2015-11-18 23:08:56,005 DEBUG : BROWSER_OUTPUT: 23:08:56 INFO - 2015-11-18 23:08:56,005 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.68 Median:191.68 stddev:0.00 (0.0%) 23:08:56 INFO - 2015-11-18 23:08:56,005 DEBUG : BROWSER_OUTPUT: Values: 191.7 23:08:56 INFO - 2015-11-18 23:08:56,005 DEBUG : BROWSER_OUTPUT: 23:08:56 INFO - 2015-11-18 23:08:56,006 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.56 Median:279.56 stddev:0.00 (0.0%) 23:08:56 INFO - 2015-11-18 23:08:56,006 DEBUG : BROWSER_OUTPUT: Values: 279.6 23:08:56 INFO - 2015-11-18 23:08:56,006 DEBUG : BROWSER_OUTPUT: 23:08:56 INFO - 2015-11-18 23:08:56,006 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5040.20 Median:5040.20 stddev:0.00 (0.0%) 23:08:56 INFO - 2015-11-18 23:08:56,006 DEBUG : BROWSER_OUTPUT: Values: 5040.2 23:08:56 INFO - 2015-11-18 23:08:56,006 DEBUG : BROWSER_OUTPUT: 23:08:56 INFO - 2015-11-18 23:08:56,006 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1081.08 Median:1081.08 stddev:0.00 (0.0%) 23:08:56 INFO - 2015-11-18 23:08:56,007 DEBUG : BROWSER_OUTPUT: Values: 1081.1 23:08:56 INFO - 2015-11-18 23:08:56,007 DEBUG : BROWSER_OUTPUT: 23:08:56 INFO - 2015-11-18 23:08:56,007 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:715.00 Median:715.00 stddev:0.00 (0.0%) 23:08:56 INFO - 2015-11-18 23:08:56,007 DEBUG : BROWSER_OUTPUT: Values: 715.0 23:08:56 INFO - 2015-11-18 23:08:56,007 DEBUG : BROWSER_OUTPUT: 23:08:56 INFO - 2015-11-18 23:08:56,007 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12195.12 Median:12195.12 stddev:0.00 (0.0%) 23:08:56 INFO - 2015-11-18 23:08:56,007 DEBUG : BROWSER_OUTPUT: Values: 12195.1 23:08:56 INFO - 2015-11-18 23:08:56,008 DEBUG : BROWSER_OUTPUT: 23:08:56 INFO - 2015-11-18 23:08:56,008 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25897.44 Median:25897.44 stddev:0.00 (0.0%) 23:08:56 INFO - 2015-11-18 23:08:56,008 DEBUG : BROWSER_OUTPUT: Values: 25897.4 23:08:56 INFO - 2015-11-18 23:08:56,008 DEBUG : BROWSER_OUTPUT: 23:08:56 INFO - 2015-11-18 23:08:56,008 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:621.12 Median:621.12 stddev:0.00 (0.0%) 23:08:56 INFO - 2015-11-18 23:08:56,008 DEBUG : BROWSER_OUTPUT: Values: 621.1 23:08:56 INFO - 2015-11-18 23:08:56,008 DEBUG : BROWSER_OUTPUT: 23:08:56 INFO - 2015-11-18 23:08:56,008 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 23:08:56 INFO - 2015-11-18 23:08:56,009 DEBUG : BROWSER_OUTPUT: Values: 4840.6 23:08:56 INFO - 2015-11-18 23:08:56,009 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 23:08:56 INFO - 2015-11-18 23:08:56,009 DEBUG : BROWSER_OUTPUT: 23:08:56 INFO - 2015-11-18 23:08:56,985 INFO : Browser exited with error code: 0 23:08:57 INFO - 2015-11-18 23:08:57,002 INFO : Completed test v8_7 (00:00:41) 23:08:57 INFO - 2015-11-18 23:08:57,008 INFO : Completed test suite (00:20:21) 23:08:57 INFO - 2015-11-18 23:08:57,009 DEBUG : Working with test: dromaeo_css 23:08:57 INFO - 2015-11-18 23:08:57,009 DEBUG : Generating results file: dromaeo_css 23:08:57 INFO - 2015-11-18 23:08:57,009 DEBUG : Working with test: kraken 23:08:57 INFO - 2015-11-18 23:08:57,009 DEBUG : Generating results file: kraken 23:08:57 INFO - 2015-11-18 23:08:57,009 INFO : javascript benchmark 23:08:57 INFO - 2015-11-18 23:08:57,010 DEBUG : Working with test: v8_7 23:08:57 INFO - 2015-11-18 23:08:57,010 DEBUG : Generating results file: v8_7 23:08:57 INFO - 2015-11-18 23:08:57,010 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:08:57 INFO - 2015-11-18 23:08:57,063 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 23:08:57 INFO - 2015-11-18 23:08:57,063 DEBUG : process_Request line: dromaeo_css 5876.68 graph.html#tests=[[72,132,43]] 23:08:57 INFO - 2015-11-18 23:08:57,063 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:08:57 INFO - 2015-11-18 23:08:57,093 DEBUG : process_Request line: kraken 1566.90 graph.html#tests=[[232,132,43]] 23:08:57 INFO - 2015-11-18 23:08:57,093 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:08:57 INFO - 2015-11-18 23:08:57,121 DEBUG : process_Request line: v8_7 21262.95 graph.html#tests=[[230,132,43]] 23:08:57 INFO - 2015-11-18 23:08:57,122 INFO : javascript benchmark 23:08:57 INFO - 2015-11-18 23:08:57,126 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2702.581099929511, 2739.2877851758535, 2781.249062753057, 2789.9442011159763, 2805.060304797892, 4525.117602067598, 4689.695169813964, 4750.643701722372, 4818.831340903069, 4821.27680847873, 4536.0, 4561.657875659323, 4678.345031695557, 4800.9519904800945, 4816.301636262749, 4254.723442976205, 4348.130373925228, 4375.124975004996, 4404.361367601696, 4431.335299705054, 4299.699021068526, 4365.912681746363, 4378.058717375764, 4456.844010459635, 4529.00361920377, 4097.713160078795, 4202.915941681149, 4429.601335879786, 4430.822767089313, 4479.888002799939, 4278.893027674302, 4374.912501749979, 4377.584129507723, 4395.428594282755, 4401.515833258339, 4265.573442655741, 4304.634106100985, 4358.953851075719, 4382.320740285261, 4404.207242696313, 4389.9464128609225, 4562.634989200889, 4645.117427688729, 4665.766711664403, 4730.62155027597, 5133.871653208662, 5143.897122057538, 5146.897062058775, 5161.535461808456, 5161.922571161435, 5142.665726727788, 5179.637425380225, 5181.937702770923, 5185.0, 5221.2951251580935, 4463.174312752151, 4597.402337696078, 4633.096546173531, 4707.670463067621, 4760.500147484534, 5187.63686541946, 5191.9480805192225, 5193.0, 5213.52801697242, 5226.790928362899, 4997.90004199914, 4999.3000979862845, 5004.099262132851, 5004.249362595567, 5017.197248440232, 4705.6000239979985, 4890.877728056827, 4972.801087956514, 5053.216751403538, 5111.539961403417, 5106.4893510648635, 5144.8713782155, 5148.394307726022, 5152.9742351288005, 5192.714400707997, 4804.183288840905, 5092.465291144451, 5105.055564720538, 5121.667091639106, 5124.897502049938, 4106.77412742302, 4174.352975288835, 4178.791060447026, 4183.205191013698, 4224.5353011168745, 3748.9437658435145, 3762.473253744478, 3772.7359084863797, 3782.659560639501, 3802.125511132455, 4221.387898754725, 4320.243957307459, 4442.666799989949, 4455.353973673799, 4458.08609235106, 5025.597952163818, 5104.132297509433, 5117.744112794346, 5118.334616499831, 5136.409312928986, 4365.694401391872, 4383.211022016004, 4415.094905544356, 4420.624246938982, 4471.3516540102155, 4339.7613131278085, 4402.537733537996, 4464.799084041161, 4548.067646132535, 4554.908901821945, 4869.853904382874, 4879.4876537963, 4903.190973489405, 4909.1654418748185, 4935.481774413778, 5131.56381707559, 5132.5124113209185, 5134.255532947627, 5134.306868572695, 5151.098557752303, 4599.310103484504, 4730.858074257778, 4793.304970779287, 4914.041761856403, 4917.852464426073, 4982.975085124551, 4984.651074424755, 4987.650864439454, 5016.247562865599, 5045.520675535819, 5077.466865979167, 5079.644424890223, 5082.161443361804, 5088.59291256706, 5115.002574498086, 4753.500882407436, 4880.585150262267, 4885.560299573055, 4966.279889416087, 4966.304717339503, 4943.752812359439, 5000.374953130859, 5008.824691135793, 5027.7234752087525, 5062.873428164326, 4575.428071491064, 4914.533119353656, 4917.385326834145, 4926.5073492650445, 4939.876503087452, 4860.392450943632, 4867.0, 4930.989147224882, 4944.035912996931, 4980.626453016111, 4888.2911977762315, 4893.266010098514, 4910.21436570147, 4921.704697718148, 4939.53074457926], "unit": "ms", "name": "dojo.html", "value": 4657.430556908608}, {"lowerIsBetter": false, "replicates": [562.828337357106, 570.7089384413949, 570.9714514274287, 581.8894410062088, 628.0986783965008, 37080.25839483209, 37513.624863751356, 37527.81236093816, 37581.812090939544, 37726.0, 38082.619173808256, 38726.225475490544, 38752.0, 38757.22485550287, 38836.41745373815, 7784.416168787336, 7901.367890568741, 7965.840683186333, 7969.9203007970045, 7973.521588704696, 7693.49992250502, 7843.686252549891, 7852.254035866584, 7852.450328476981, 7854.410919181056, 7780.260875216845, 7830.373570114406, 7864.685412583518, 7877.881831772528, 7894.881576776353, 7565.508241964255, 7575.924240757577, 7593.886091708629, 7594.620268986556, 7605.239476052406, 7688.769336919901, 7836.216378362175, 7852.725154619618, 7870.645820938014, 7887.763367098996, 35670.28659426797, 36063.0, 36089.0, 36098.81950590257, 36195.81902090499, 2810.8594570271607, 2924.268932766808, 3064.4637188491924, 3310.6854848789567, 3521.996231074157, 27546.86226568854, 27731.86134069317, 27869.86065069682, 28168.436631267465, 28221.153365398866, 2923.3276346440225, 2947.277916910349, 2979.7318241358166, 3013.9397212055856, 3064.6475655299705, 214036.0, 215446.0, 215539.0, 216362.91818540965, 216610.0, 37877.81061094677, 39152.80423597864, 51335.74332128315, 51542.22686659703, 51630.741846290526, 56580.43419565834, 56706.0, 57079.0, 57165.0, 57404.71297643485, 11290.604828831116, 11352.602658906899, 11373.658790236306, 11380.601678941362, 11457.942710286396, 8921.821563568823, 8934.776630584287, 8982.910170898207, 8989.0, 9012.233960113334, 17529.860559063876, 17823.643527129385, 17959.73060404095, 17973.550661233574, 18004.45986620377, 7040.577565346096, 7315.626573098898, 7348.889766653505, 7406.222346653523, 7426.405887528985, 823.8887750153652, 917.7934964632905, 919.2829592917535, 933.7478880702172, 977.9119879210763, 26421.603675944876, 26435.339116522242, 27822.721772782417, 28332.858335708603, 29034.709652903624, 897.537768049455, 902.7923577577194, 914.433051508056, 926.6941909169958, 961.3510880155867, 12907.419166137546, 13080.0, 13108.410121544553, 14470.855291447162, 14968.02707823988, 254435.0, 256260.0, 256518.0, 257436.0, 257712.0, 46609.766951165024, 46656.7667161662, 46807.0, 46852.297215541796, 46910.765446172554, 1128.238439053652, 1131.4003578103618, 1132.5639628742829, 1134.2570616246371, 1135.0182092490102, 26007.60988585135, 26340.0, 26434.07480738165, 26448.338791530365, 26611.86694066517, 42951.785241073594, 43338.13323733571, 43412.0, 43680.0, 43768.562314376446, 213203.0, 215884.0, 216144.0, 216407.0, 217459.0, 28390.0, 29059.7094029057, 29125.7087429123, 29411.11766647004, 29589.704102959557, 33453.0, 33601.0, 33648.0, 34414.82792586021, 34489.65510344865, 29267.414651706422, 29423.26441838971, 29729.0, 29783.404331913673, 30412.806655300876, 31546.0, 31584.519350811486, 32002.67997319997, 32171.51742723908, 32306.0, 30058.0, 30123.0, 30192.5471117929, 30475.085747427613, 30492.542611860397, 26433.0, 27003.86498067497, 28385.85807071034, 28784.409403153815, 28930.566041508973, 21768.782312176674, 22847.200347987742, 23257.18599848997, 23477.0, 23650.29049128529], "unit": "ms", "name": "ext.html", "value": 16186.852164667944}, {"lowerIsBetter": false, "replicates": [303.75395929297264, 307.1767662664061, 311.3446195757928, 313.08422863125355, 315.9889403870864, 10525.894741052587, 10811.189160812932, 14854.628634284149, 15340.923295383522, 15625.218739063044, 9837.065478779505, 9885.555150018266, 10060.597576096965, 10282.434466104361, 10305.690829275134, 4079.6940229482757, 4152.6055024772595, 4167.520735115455, 4170.249355116078, 4198.496180458349, 3067.2945222598814, 4070.0028493019254, 4182.435371224876, 4232.74603523788, 4234.87295381139, 3148.6536480987074, 3222.9838850805713, 4146.0, 4178.059936514291, 4465.129299786543, 4495.617872480843, 4537.931931021054, 4556.111558246143, 4559.954400456003, 4563.680542362036, 3648.343298206348, 3894.0, 3908.0, 3909.4526766252748, 3927.0182454386404, 11546.307221566733, 11996.760064798742, 12007.0, 12020.699482513008, 12059.819102713467, 1715.202430869639, 1761.4539492757285, 1801.702719051355, 1816.9273229070955, 1843.0324079858049, 8680.78298042554, 8734.432261903019, 8746.125387461203, 8982.640694372218, 9008.504532250723, 1576.637373404112, 1604.8525304407287, 1614.2009705195885, 1627.8128015278276, 1633.8284480129535, 51169.74415127938, 52281.215781763305, 52350.73824630852, 52568.73715631474, 53150.734246328524, 5969.164316995624, 6060.515158787286, 6074.119252708332, 6108.17539632144, 6137.1101190328045, 7162.856742865113, 7179.89230161548, 7184.640767961581, 7188.5327453715345, 7204.567725936356, 4651.116287905287, 4667.323238130452, 4675.2052151134385, 4710.317004034396, 4721.551452611996, 4704.835330763407, 4721.716696998191, 4725.220338644154, 4756.0, 4760.309755085494, 2794.1477849255766, 2795.4968105740754, 2795.664520257582, 2804.5232310507263, 2819.7603203727504, 997.5311603546321, 1002.04304888831, 1010.3533738407425, 1010.6412223660642, 1068.8557044799009, 374.1469449654791, 383.4688955796187, 409.86064737989227, 412.7853516171574, 428.35532523551854, 9257.629694812267, 10546.630867919586, 10581.682549523526, 10896.836547451794, 11102.555897764161, 406.67872380818824, 408.57100044953273, 412.08517092055587, 415.2318211309054, 415.87523742877016, 5761.48146666802, 5889.499392551681, 5968.9701551492835, 5972.58191926561, 6043.002904520793, 426370.0, 426508.0, 428888.0, 429214.0, 435922.0, 64920.0, 65292.67353663201, 65411.672941634984, 66487.33512664908, 67149.0, 457.53103069354177, 458.3605869811661, 459.3018611710182, 462.3180808307786, 469.9600533954584, 9341.532923353941, 9472.147506724428, 9486.484871422048, 9590.952045239728, 9618.807623847624, 31176.844115780183, 31312.686873130977, 31517.842410787798, 31984.0, 32236.516452252767, 39787.40318895277, 40982.79508602438, 42631.36052959146, 43038.139237215706, 43141.784291078344, 5753.8561535961935, 5786.508146807569, 5854.209681693087, 5857.619254748598, 5860.794872179454, 9936.602535898772, 10391.064804167661, 10424.947875260576, 10480.423576703355, 10481.475926203811, 9019.639214431349, 9276.16514513697, 9518.857217141609, 9559.330846840932, 9642.855357169788, 8774.692885748967, 8967.327450441113, 9115.453072815651, 9174.724758257264, 9523.476208808583, 9396.389234699722, 9410.670626528312, 9600.32797704154, 9717.514124293899, 9750.952300017076, 5757.8560535986935, 6081.179040829431, 6093.969530152321, 6106.542009349406, 6111.908321375272, 9624.615015399306, 9649.131578158, 9704.126628603177, 9821.5089245536, 9870.802583948425], "unit": "ms", "name": "jquery.html", "value": 5995.503680844349}, {"lowerIsBetter": false, "replicates": [1486.0, 1572.3427407681017, 1615.0, 1639.7540368944656, 1653.2395098254806, 6540.182477190351, 6597.571157874735, 6634.402903738663, 6770.729170833167, 6894.13823272091, 6896.1724593048775, 6902.413294869942, 6972.96513517433, 6977.965110174455, 6979.0, 1966.5280332720115, 1992.1931617694784, 1995.092233033966, 2014.1943222710886, 2017.384697667211, 1937.3897222374978, 1961.1959096770327, 1966.0464674632792, 1985.662437385648, 1997.560536681935, 1938.8933608651519, 1942.2522328903403, 1946.9221231150736, 1980.8514361422879, 1992.6612475879135, 1841.9079046047711, 1859.2098358197711, 1860.9720854187199, 1862.9534261643432, 1867.8038805925319, 1907.9618407631908, 1939.5732938753451, 1942.2522328903474, 1943.4266891266968, 1944.4263942137104, 6793.45652347811, 6871.415929645986, 6873.965630171867, 6878.55289406187, 6899.517033807636, 3916.2559113768293, 4016.4577781999346, 4018.8593399230886, 4024.517057953035, 4030.052937559671, 2652.655154829879, 2717.1033558925506, 2757.3933734578563, 2817.0985284708695, 2827.618271533358, 856.8586183279814, 1689.5438231677379, 1731.0825262610836, 1735.2364959417816, 1737.218251786701, 8897.065808090187, 8986.415882967522, 8995.235404990584, 9009.459432434009, 9045.638174473013, 3469.7224222062173, 3489.685928266468, 3500.684938355509, 3522.788632682047, 3529.7529172957647, 7448.5158464699625, 7475.177730449646, 7492.213317601573, 7495.138059123271, 7513.812154696177, 3878.4764056852528, 3918.0204948762807, 3931.056546428894, 3945.368741001426, 3947.0, 3603.2973570154095, 3622.112582417272, 3631.618680038611, 3646.781193128421, 3656.689181419556, 2882.1641723899834, 2898.3044069423186, 2899.9275018124295, 2922.6200593922654, 2929.1359049080575, 862.7490139298043, 867.531532972188, 870.7692461497708, 871.4727589808201, 871.664409202449, 749.8612756640039, 802.9601665842748, 874.5583480342386, 931.6971984105193, 1149.40231079838, 6243.157173781481, 6410.1987251593555, 6480.805575832733, 6480.837979050467, 6484.708188131545, 592.2123575644468, 604.6432604763123, 636.1793286660156, 639.7089324357406, 724.2865777209445, 4627.3521706961055, 4684.859454216379, 4727.361806156194, 4760.738159401266, 4760.904781904343, 7950.403719721044, 8125.390595705346, 8139.674413023531, 8161.959190204011, 8167.224113709188, 7999.120096789348, 8002.359811215205, 8050.396220283385, 8065.7176998805935, 8076.313513351431, 6408.038794180817, 6412.422881940741, 6455.61266324022, 6468.3855033771715, 6480.449161821204, 6177.96911015442, 6212.534059945432, 6219.875602488016, 6222.408871157233, 6259.593126446766, 7034.824129396806, 7233.529820561646, 7267.127944646676, 7280.817979550342, 7298.087739032621, 7216.639168041682, 7438.6652600632015, 7479.850402991801, 7483.176850546327, 7493.613681468945, 5621.662700237999, 5628.74670639814, 5643.322801263875, 5654.886902261849, 5678.914816277842, 6500.0, 6551.148350714568, 6567.474602031922, 6569.277379488157, 6570.8357291068105, 5956.374580668968, 6052.364501727256, 6066.4540191382985, 6160.322364539987, 6269.153664255449, 5927.940720592911, 5983.341832398346, 6228.22147231596, 6261.499080073492, 6338.778142764981, 6141.170941922784, 6224.844378890564, 6262.373762623702, 6275.435210831047, 6275.6862156892885, 5850.12248162779, 5880.500157486662, 5896.115582662464, 5924.851878703067, 5940.970295148497, 5948.97025514887, 5949.881002380015, 5963.940360596339, 5973.193618861398, 5991.610545314715], "unit": "ms", "name": "mootools.html", "value": 3876.1816992561535}, {"lowerIsBetter": false, "replicates": [272.1508892256161, 274.51685034339556, 279.370020603539, 281.41465751237416, 281.66763219401105, 5559.527440167585, 5591.692456914868, 5608.186812912125, 5658.151277308406, 5722.055860782976, 5520.089185284433, 5557.249771280876, 5570.470805273502, 5580.665160090397, 5588.6646801191955, 4162.604552567509, 4168.916621667565, 4175.979120104411, 4178.394132850734, 4182.351735481006, 4148.149629325996, 4170.39529268256, 4170.70805043647, 4177.373393990895, 4183.163367326531, 3981.0644498542965, 4087.509498860141, 4090.5704900985415, 4128.091819799654, 4130.5043394792665, 4046.6964977626794, 4072.6538244249273, 4081.3061779497407, 4086.2236175126777, 4114.917701645951, 3505.9482155353294, 3507.719382449398, 3508.1054331145397, 3511.1924257420683, 3516.4197907345256, 5361.705106219157, 5369.838904832861, 5374.005808925362, 5378.46215378463, 5385.030694474993, 4628.606568441686, 4749.050189961987, 4751.3348131261655, 4758.1673207188605, 4760.857174284777, 5697.829065128053, 5791.82624521265, 5837.532997360201, 5837.978353788112, 5853.209816674737, 3806.695464362844, 3842.4428457873732, 3847.576766555677, 3853.9421908671393, 3854.2676891390824, 6003.429674180989, 6129.957907155795, 6151.2618485781995, 6161.907571386388, 6162.075688646694, 3801.4867992820614, 3903.277893589695, 3936.389859571771, 3941.4087886817206, 3958.604139586076, 4005.619466150711, 4007.8396864125693, 4012.9398059029136, 4016.196760647824, 4034.0923292259595, 4698.765061746899, 4709.67032307742, 4736.550027747358, 4736.976315118472, 4744.786484608201, 5864.266966629171, 5880.8235752927485, 5884.58807883444, 5886.117082437669, 5886.793962211302, 1373.7527245095978, 1380.7169530246276, 1395.6789938314243, 1402.4250057476386, 1414.5473448496382, 913.1872633356318, 921.2629896083241, 924.4314746430897, 931.5621657820949, 932.3147486597345, 4985.750712464434, 5042.520960508746, 5049.2426136079885, 5083.466236045236, 5084.949150508522, 5960.225170727777, 6002.879942401128, 6012.398760123952, 6015.909761353583, 6020.157177995085, 4986.750662466862, 5061.31672224245, 5069.417017043013, 5072.416672082758, 5076.0863044652315, 3208.374366998413, 3219.3078488124697, 3278.7213086887405, 3298.9175270618425, 3303.752218583568, 5765.07758758605, 5766.769329226784, 5773.884522309614, 5847.298324201123, 5852.122181672783, 6360.968195159087, 6361.650109243943, 6362.586431881913, 6366.076918846834, 6371.044343348535, 5686.0, 5757.078867381283, 5839.678817665069, 5841.7371218295275, 5848.912266316009, 6140.5394595406415, 6143.84640383994, 6162.784302549389, 6164.4143806338325, 6169.691515424301, 5988.490978266722, 6015.729292181775, 6016.037434010537, 6017.338092809875, 6022.638641681513, 5785.450382213683, 5807.012807822764, 5813.331466881363, 5819.359870414336, 5830.591858569859, 3881.7865017424315, 3941.8029098544384, 3986.980065099656, 3998.7600743955454, 4000.419939108871, 5980.5514586405325, 6149.84625384369, 6154.876902462015, 6157.53818463626, 6158.661273629993, 5858.384869588802, 5860.38465961085, 5875.0, 5892.499137573354, 5909.8227053188475, 5826.329972053099, 5830.708464576839, 5838.591298609226, 5844.386339434468, 5857.414258574279, 5645.842602266608, 5717.514011308919, 5717.799877004285, 5758.107493338539, 5763.0, 5864.237649105589, 5921.259842519685, 5923.703814809156, 5928.822135335947, 5932.080527518242, 5699.316082070178, 5726.398728133486, 5735.283089613798, 5742.3109226891365, 5746.42535746422], "unit": "ms", "name": "prototype.html", "value": 4300.785887932752}, {"lowerIsBetter": false, "replicates": [646.0890144895698, 763.2062654838971, 764.4037650632507, 778.3500776851329, 783.185487093423, 11626.825597616042, 11836.822447663271, 11857.644270671894, 11861.406929653525, 11865.288082715033, 11667.883321166786, 11749.647510574676, 11899.167058305922, 11950.103742219324, 12011.159218854684, 756.3457609168086, 781.6834182156222, 784.047382430347, 794.5431376958243, 795.5664163031133, 745.8769303064988, 772.5557804262544, 779.3726050529322, 781.1680560203393, 783.8706613408781, 809.8137428391474, 814.914433984432, 816.0411516468156, 816.5141740664325, 817.1542453560565, 805.9516429014249, 807.2129673568282, 811.6023148657144, 814.9633266503022, 816.102287483769, 591.4676790888192, 592.943670351316, 593.2199158107076, 594.0969726016474, 595.1905408644241, 12069.456874440672, 12245.448954797055, 12300.446479908425, 12311.384430778426, 12344.0, 8631.827363452696, 9278.164965153168, 9444.386114902578, 9602.08780165883, 9664.565094570691, 8382.329413646894, 8824.205821476035, 9001.819963600758, 9055.139761722627, 9143.771405714844, 2972.078655616744, 2990.386970671029, 3002.594649722303, 3014.804037737562, 3078.245829771698, 38623.42064869029, 38650.613493864985, 38778.61221387778, 38860.805695971336, 39313.0, 6941.30586941312, 6957.61733104674, 7059.329363710439, 7093.051572727084, 7141.892871606826, 10507.159427245955, 10530.0, 10539.789204215873, 10550.419726914939, 10574.101201397967, 5602.859928501739, 5684.175794509773, 5689.68706721126, 5717.3996730342715, 5895.41045895407, 3512.8946131616094, 3528.770629909048, 3538.168530395355, 3546.0957455848593, 3673.9632603674154, 2280.9771902280763, 2295.632698768189, 2296.8851557422063, 2298.287530865437, 2304.2396009316885, 432.8398492557774, 444.7842796243819, 448.03895643844425, 448.22233425007585, 459.51521145192146, 463.3536216977298, 521.7026295011807, 545.6535100211395, 613.9815805525841, 627.5387590121258, 7874.72438464651, 7997.120316765151, 7999.720009799629, 8117.228863258099, 8143.226393492609, 443.62513675943774, 466.0818188169301, 492.849680847345, 579.1660009586183, 651.3681728723226, 3655.469956856241, 3805.4291856221234, 3851.6340947609933, 3853.2678791029616, 3892.824822882977, 50550.0, 51054.744726276134, 51306.48693513092, 51517.0, 52005.7399712999, 45950.5404945953, 46088.769556152, 47149.76425117852, 47859.28211076836, 48894.75552622214, 41431.79284103621, 41515.377269340985, 41562.792186038874, 41929.58070419318, 42390.57609423866, 8179.83640327202, 8216.383771217303, 8554.230119289294, 8611.354148439017, 8742.91257087421, 30793.076207713806, 30887.382252355277, 31320.68679313269, 31949.840250798596, 32194.517082244252, 36407.45388819223, 36870.44694329641, 37010.0, 41185.0, 41504.377434337905, 7104.3961263293195, 7323.780286591411, 7410.848067126118, 7443.404527637667, 7608.429367797326, 11209.831852522382, 11363.602273920373, 11551.942240288745, 11562.768744624893, 11615.825762613398, 10235.181185505291, 10304.742381440225, 10510.0, 10877.238593298393, 10885.23803333759, 10563.63027294041, 10806.891931080589, 10823.134149268197, 10919.126469882549, 11245.493952772309, 9450.574724137292, 9892.950535247277, 10846.511906964048, 10864.076553493042, 10963.287386319864, 9079.59141838632, 9146.95426522863, 9342.252619790537, 9485.430874147572, 9744.707658770249, 8432.53621050848, 8732.476051436934, 9019.774505637411, 9076.455412675261, 9291.303152263472], "unit": "ms", "name": "yui.html", "value": 5465.952807999019}], "name": "dromaeo_css", "value": 5876.683613077805}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [117.0, 109.0, 116.0, 114.0, 116.0, 128.0, 114.0, 115.0, 113.0, 116.0], "unit": "ms", "name": "ai-astar", "value": 115.8}, {"lowerIsBetter": true, "replicates": [156.0, 133.0, 155.0, 168.0, 144.0, 162.0, 156.0, 134.0, 168.0, 143.0], "unit": "ms", "name": "audio-beat-detection", "value": 151.9}, {"lowerIsBetter": true, "replicates": [163.0, 164.0, 165.0, 164.0, 163.0, 165.0, 168.0, 161.0, 165.0, 164.0], "unit": "ms", "name": "audio-dft", "value": 164.2}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 73.0, 73.0, 85.0, 73.0, 148.0, 73.0, 74.0, 74.0], "unit": "ms", "name": "audio-fft", "value": 81.8}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 136.0, 93.0, 92.0, 92.0, 133.0, 92.0, 93.0, 134.0], "unit": "ms", "name": "audio-oscillator", "value": 104.9}, {"lowerIsBetter": true, "replicates": [110.0, 111.0, 111.0, 111.0, 110.0, 110.0, 110.0, 110.0, 110.0, 115.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.8}, {"lowerIsBetter": true, "replicates": [149.0, 149.0, 149.0, 149.0, 149.0, 149.0, 149.0, 150.0, 150.0, 150.0], "unit": "ms", "name": "imaging-darkroom", "value": 149.3}, {"lowerIsBetter": true, "replicates": [96.0, 99.0, 96.0, 96.0, 101.0, 100.0, 98.0, 97.0, 96.0, 97.0], "unit": "ms", "name": "imaging-desaturate", "value": 97.6}, {"lowerIsBetter": true, "replicates": [75.0, 74.0, 75.0, 75.0, 77.0, 76.0, 77.0, 80.0, 77.0, 72.0], "unit": "ms", "name": "json-parse-financial", "value": 75.8}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 70.0, 70.0, 70.0, 71.0, 70.0, 69.0, 70.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.8}, {"lowerIsBetter": true, "replicates": [91.0, 84.0, 87.0, 84.0, 88.0, 85.0, 94.0, 97.0, 86.0, 86.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 88.2}, {"lowerIsBetter": true, "replicates": [122.0, 151.0, 139.0, 124.0, 127.0, 129.0, 129.0, 134.0, 128.0, 122.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 130.5}, {"lowerIsBetter": true, "replicates": [144.0, 154.0, 155.0, 157.0, 160.0, 159.0, 155.0, 158.0, 156.0, 142.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 154.0}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 74.0, 76.0, 73.0, 73.0, 71.0, 71.0, 71.0, 72.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 72.3}], "name": "kraken", "value": 1566.8999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.44474034620507], "unit": "score", "name": "Richards", "value": 212.09441600000005}, {"lowerIsBetter": false, "replicates": [191.68104274487254], "unit": "score", "name": "DeltaBlue", "value": 344.937606}, {"lowerIsBetter": false, "replicates": [279.56388034665923], "unit": "score", "name": "Encrypt", "value": 952.1294369999999}, {"lowerIsBetter": false, "replicates": [5040.201005025126], "unit": "score", "name": "Decrypt", "value": 52.81158424725827}, {"lowerIsBetter": false, "replicates": [1081.081081081081], "unit": "score", "name": "RayTrace", "value": 684.4898250000002}, {"lowerIsBetter": false, "replicates": [715.0], "unit": "score", "name": "Earley", "value": 932.1160839160838}, {"lowerIsBetter": false, "replicates": [12195.121951219513], "unit": "score", "name": "Boyer", "value": 54.64996600000001}, {"lowerIsBetter": false, "replicates": [25897.4358974359], "unit": "score", "name": "RegExp", "value": 35.17664851485149}, {"lowerIsBetter": false, "replicates": [621.1180124223603], "unit": "score", "name": "Splay", "value": 131.20050999999998}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 21262.945766834888}]} 23:08:57 INFO - RETURN: dromaeo_css: 5876.68 23:08:57 INFO - RETURN: kraken: 1566.90 23:08:57 INFO - RETURN: v8_7: 21262.95 23:08:57 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21262.95"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1566.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "5876.68"}}} 23:08:57 INFO - Return code: 0 23:08:57 INFO - # TBPL SUCCESS # 23:08:57 INFO - Running post-action listener: _resource_record_post_action 23:08:57 INFO - Running post-run listener: _resource_record_post_run 23:08:58 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 8192; Write bytes: 498917376; Read time: 260; Write time: 773164 23:08:58 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 94445568; Read time: 0; Write time: 103804 23:08:58 INFO - run-tests - Wall time: 1222s; CPU: 13.0%; Read bytes: 4096; Write bytes: 346677248; Read time: 12; Write time: 538816 23:08:58 INFO - Running post-run listener: _upload_blobber_files 23:08:58 INFO - Blob upload gear active. 23:08:58 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 23:08:58 INFO - Copying logs to upload dir... 23:08:58 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1271.889028 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2015-11-18 23:08:58.236155) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-18 23:08:58.239512) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c54e757a4c805d85fea3bc7000001f2-1447913990.296135-670975499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/GSTTXjJ6QiC_BQssQfh9Gw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010105 build_url: 'https://queue.taskcluster.net/v1/task/GSTTXjJ6QiC_BQssQfh9Gw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-18 23:08:58.291073) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 23:08:58.291408) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c54e757a4c805d85fea3bc7000001f2-1447913990.296135-670975499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004547 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 23:08:58.341329) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 23:08:58.341637) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 23:08:58.341939) ========= ========= Total master_lag: 0.23 =========