builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-018 starttime: 1447860823.11 results: success (0) buildid: 20151118062325 builduid: 5d0b600731194e44af48852715ead046 revision: 44f58c7fc121e68854da500798ef84c0f432a32a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 07:33:43.114110) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 07:33:43.114665) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 07:33:43.114979) ========= 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=6d5287d839824eebc594b0c9000001d1-1447859883.469125-1934920036 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006484 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 07:33:43.136409) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 07:33:43.136828) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 07:33:43.150361) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 07:33:43.150732) ========= 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=6d5287d839824eebc594b0c9000001d1-1447859883.469125-1934920036 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004561 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 07:33:43.206289) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 07:33:43.206752) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 07:33:43.207130) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 07:33:43.207662) ========= 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=6d5287d839824eebc594b0c9000001d1-1447859883.469125-1934920036 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-18 07:33:43-- 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% 223M=0s 2015-11-18 07:33:43 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.164362 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 07:33:43.385644) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 07:33:43.385959) ========= 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=6d5287d839824eebc594b0c9000001d1-1447859883.469125-1934920036 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020249 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 07:33:43.435896) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-18 07:33:43.436328) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 44f58c7fc121e68854da500798ef84c0f432a32a --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 44f58c7fc121e68854da500798ef84c0f432a32a --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=6d5287d839824eebc594b0c9000001d1-1447859883.469125-1934920036 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-18 07:33:43,584 truncating revision to first 12 chars 2015-11-18 07:33:43,584 Setting DEBUG logging. 2015-11-18 07:33:43,585 attempt 1/10 2015-11-18 07:33:43,585 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/44f58c7fc121?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-18 07:33:44,891 unpacking tar archive at: fx-team-44f58c7fc121/testing/mozharness/ program finished with exit code 0 elapsedTime=1.609450 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-18 07:33:45.059110) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 07:33:45.059435) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 07:33:45.068175) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 07:33:45.068466) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 07:33:45.068912) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-11-18 07:33:45.069198) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d5287d839824eebc594b0c9000001d1-1447859883.469125-1934920036 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:33:45 INFO - MultiFileLogger online at 20151118 07:33:45 in /builds/slave/test 07:33:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 07:33:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:33:45 INFO - {'append_to_log': False, 07:33:45 INFO - 'base_work_dir': '/builds/slave/test', 07:33:45 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 07:33:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:33:45 INFO - 'branch': 'Fx-Team-Non-PGO', 07:33:45 INFO - 'buildbot_json_path': 'buildprops.json', 07:33:45 INFO - 'config_files': ('talos/linux_config.py',), 07:33:45 INFO - 'default_actions': ('clobber', 07:33:45 INFO - 'read-buildbot-config', 07:33:45 INFO - 'download-and-extract', 07:33:45 INFO - 'populate-webroot', 07:33:45 INFO - 'create-virtualenv', 07:33:45 INFO - 'install', 07:33:45 INFO - 'run-tests'), 07:33:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:33:45 INFO - 'download_minidump_stackwalk': True, 07:33:45 INFO - 'download_symbols': 'ondemand', 07:33:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:33:45 INFO - 'tooltool.py': '/tools/tooltool.py', 07:33:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:33:45 INFO - '/tools/misc-python/virtualenv.py')}, 07:33:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:33:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:33:45 INFO - 'installer_path': 'installer.exe', 07:33:45 INFO - 'log_level': 'info', 07:33:45 INFO - 'log_name': 'talos', 07:33:45 INFO - 'log_to_console': True, 07:33:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:33:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:33:45 INFO - 'opt_config_files': (), 07:33:45 INFO - 'pip_index': False, 07:33:45 INFO - 'sps_profile': False, 07:33:45 INFO - 'sps_profile_interval': 0, 07:33:45 INFO - 'suite': 'dromaeojs', 07:33:45 INFO - 'system_bits': '64', 07:33:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:33:45 INFO - 'title': 'talos-linux64-ix-018', 07:33:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:33:45 INFO - 'use_talos_json': True, 07:33:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:33:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:33:45 INFO - 'work_dir': 'build'} 07:33:45 INFO - ##### 07:33:45 INFO - ##### Running clobber step. 07:33:45 INFO - ##### 07:33:45 INFO - Running pre-action listener: _resource_record_pre_action 07:33:45 INFO - Running main action method: clobber 07:33:45 INFO - rmtree: /builds/slave/test/build 07:33:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:33:45 INFO - Running post-action listener: _resource_record_post_action 07:33:45 INFO - ##### 07:33:45 INFO - ##### Running read-buildbot-config step. 07:33:45 INFO - ##### 07:33:45 INFO - Running pre-action listener: _resource_record_pre_action 07:33:45 INFO - Running main action method: read_buildbot_config 07:33:45 INFO - Using buildbot properties: 07:33:45 INFO - { 07:33:45 INFO - "properties": { 07:33:45 INFO - "buildnumber": 892, 07:33:45 INFO - "product": "firefox", 07:33:45 INFO - "script_repo_revision": "production", 07:33:45 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 07:33:45 INFO - "repository": "", 07:33:45 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 07:33:45 INFO - "buildid": "20151118062325", 07:33:45 INFO - "slavename": "talos-linux64-ix-018", 07:33:45 INFO - "pgo_build": "False", 07:33:45 INFO - "basedir": "/builds/slave/test", 07:33:45 INFO - "project": "", 07:33:45 INFO - "platform": "ubuntu64_hw", 07:33:45 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:33:45 INFO - "slavebuilddir": "test", 07:33:45 INFO - "scheduler": "tests-fx-team-linux64-talos", 07:33:45 INFO - "branch": "fx-team", 07:33:45 INFO - "repo_path": "integration/fx-team", 07:33:45 INFO - "stage_platform": "linux64", 07:33:45 INFO - "builduid": "5d0b600731194e44af48852715ead046", 07:33:45 INFO - "revision": "44f58c7fc121e68854da500798ef84c0f432a32a" 07:33:45 INFO - }, 07:33:45 INFO - "sourcestamp": { 07:33:45 INFO - "repository": "", 07:33:45 INFO - "hasPatch": false, 07:33:45 INFO - "project": "", 07:33:45 INFO - "branch": "fx-team-linux64-talos", 07:33:45 INFO - "changes": [ 07:33:45 INFO - { 07:33:45 INFO - "category": null, 07:33:45 INFO - "files": [ 07:33:45 INFO - { 07:33:45 INFO - "url": null, 07:33:45 INFO - "name": "https://queue.taskcluster.net/v1/task/HSYjftOxQF-CX1F5o09Qog/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 07:33:45 INFO - } 07:33:45 INFO - ], 07:33:45 INFO - "repository": "", 07:33:45 INFO - "rev": "44f58c7fc121e68854da500798ef84c0f432a32a", 07:33:45 INFO - "who": "cbook@mozilla.com", 07:33:45 INFO - "when": 1447860722, 07:33:45 INFO - "number": 6677300, 07:33:45 INFO - "comments": "Merge mozilla-central to fx-team", 07:33:45 INFO - "project": "", 07:33:45 INFO - "at": "Wed 18 Nov 2015 07:32:02", 07:33:45 INFO - "branch": "fx-team-linux64-talos", 07:33:45 INFO - "revlink": "", 07:33:45 INFO - "properties": [ 07:33:45 INFO - [ 07:33:45 INFO - "buildid", 07:33:45 INFO - "20151118062325", 07:33:45 INFO - "Change" 07:33:45 INFO - ], 07:33:45 INFO - [ 07:33:45 INFO - "builduid", 07:33:45 INFO - "5d0b600731194e44af48852715ead046", 07:33:45 INFO - "Change" 07:33:45 INFO - ], 07:33:45 INFO - [ 07:33:45 INFO - "pgo_build", 07:33:45 INFO - "False", 07:33:45 INFO - "Change" 07:33:45 INFO - ] 07:33:45 INFO - ], 07:33:45 INFO - "revision": "44f58c7fc121e68854da500798ef84c0f432a32a" 07:33:45 INFO - } 07:33:45 INFO - ], 07:33:45 INFO - "revision": "44f58c7fc121e68854da500798ef84c0f432a32a" 07:33:45 INFO - } 07:33:45 INFO - } 07:33:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/HSYjftOxQF-CX1F5o09Qog/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 07:33:45 INFO - Running post-action listener: _resource_record_post_action 07:33:45 INFO - ##### 07:33:45 INFO - ##### Running download-and-extract step. 07:33:45 INFO - ##### 07:33:45 INFO - Running pre-action listener: _resource_record_pre_action 07:33:45 INFO - Running main action method: download_and_extract 07:33:45 INFO - mkdir: /builds/slave/test/build/tests 07:33:45 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')]} 07:33:45 INFO - https://queue.taskcluster.net/v1/task/HSYjftOxQF-CX1F5o09Qog/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:33:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSYjftOxQF-CX1F5o09Qog/artifacts/public/build/test_packages.json 07:33:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSYjftOxQF-CX1F5o09Qog/artifacts/public/build/test_packages.json 07:33:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSYjftOxQF-CX1F5o09Qog/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 07:33:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSYjftOxQF-CX1F5o09Qog/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 07:33:46 INFO - Downloaded 1302 bytes. 07:33:46 INFO - Reading from file /builds/slave/test/build/test_packages.json 07:33:46 INFO - Using the following test package requirements: 07:33:46 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 07:33:46 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:33:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:33:46 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:33:46 INFO - u'jsshell-linux-x86_64.zip'], 07:33:46 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:33:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:33:46 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 07:33:46 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:33:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:33:46 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:33:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:33:46 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:33:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:33:46 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 07:33:46 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:33:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:33:46 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:33: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')]} 07:33:46 INFO - https://queue.taskcluster.net/v1/task/HSYjftOxQF-CX1F5o09Qog/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:33:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSYjftOxQF-CX1F5o09Qog/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:33:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSYjftOxQF-CX1F5o09Qog/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:33:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSYjftOxQF-CX1F5o09Qog/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 07:33:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSYjftOxQF-CX1F5o09Qog/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 07:33:47 INFO - Downloaded 21277656 bytes. 07:33:47 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 07:33:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:33:47 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 07:33:49 INFO - Return code: 0 07:33:49 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 07:33:49 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')]} 07:33:49 INFO - https://queue.taskcluster.net/v1/task/HSYjftOxQF-CX1F5o09Qog/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:33:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSYjftOxQF-CX1F5o09Qog/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:33:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSYjftOxQF-CX1F5o09Qog/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:33:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSYjftOxQF-CX1F5o09Qog/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 07:33:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSYjftOxQF-CX1F5o09Qog/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 07:33:50 INFO - Downloaded 21277656 bytes. 07:33: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 07:33:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:33: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 07:33:51 INFO - Return code: 0 07:33: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')]} 07:33:51 INFO - https://queue.taskcluster.net/v1/task/HSYjftOxQF-CX1F5o09Qog/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:33:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSYjftOxQF-CX1F5o09Qog/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 07:33:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSYjftOxQF-CX1F5o09Qog/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 07:33:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSYjftOxQF-CX1F5o09Qog/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 07:33:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSYjftOxQF-CX1F5o09Qog/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 07:33:52 INFO - Downloaded 11130997 bytes. 07:33:52 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 07:33:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 07:33:52 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 07:33:52 INFO - Return code: 0 07:33:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:33:52 INFO - https://queue.taskcluster.net/v1/task/HSYjftOxQF-CX1F5o09Qog/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:33:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSYjftOxQF-CX1F5o09Qog/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:33:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSYjftOxQF-CX1F5o09Qog/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:33:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSYjftOxQF-CX1F5o09Qog/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 07:33:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSYjftOxQF-CX1F5o09Qog/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 07:33:56 INFO - Downloaded 55661126 bytes. 07:33:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HSYjftOxQF-CX1F5o09Qog/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:33:56 INFO - mkdir: /builds/slave/test/properties 07:33:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:33:56 INFO - Writing to file /builds/slave/test/properties/build_url 07:33:56 INFO - Contents: 07:33:56 INFO - build_url:https://queue.taskcluster.net/v1/task/HSYjftOxQF-CX1F5o09Qog/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:33:56 INFO - Running post-action listener: _resource_record_post_action 07:33:56 INFO - Running post-action listener: set_extra_try_arguments 07:33:56 INFO - ##### 07:33:56 INFO - ##### Running populate-webroot step. 07:33:56 INFO - ##### 07:33:56 INFO - Running pre-action listener: _resource_record_pre_action 07:33:56 INFO - Running main action method: populate_webroot 07:33:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:33:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:33:56 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 07:33:56 INFO - '../fennec_ids.txt'], 07:33:56 INFO - 'tests': ['tcheck2']}, 07:33:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:33:56 INFO - '--tppagecycles', 07:33:56 INFO - '7'], 07:33:56 INFO - 'tests': ['tsvgm']}}, 07:33:56 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:33:56 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:33:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:33:56 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:33:56 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:33:56 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:33:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:33:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:33:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:33:56 INFO - 'talos_options': ['--e10s'], 07:33:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:33:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:33:56 INFO - 'tests': ['damp', 'tps']}, 07:33:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:33:56 INFO - 'talos_options': ['--e10s'], 07:33:56 INFO - 'tests': ['damp', 'tps']}, 07:33:56 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:33:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:33:56 INFO - 'other': {'tests': ['a11yr', 07:33:56 INFO - 'ts_paint', 07:33:56 INFO - 'tpaint', 07:33:56 INFO - 'sessionrestore', 07:33:56 INFO - 'sessionrestore_no_auto_restore']}, 07:33:56 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:33:56 INFO - 'tests': ['a11yr', 07:33:56 INFO - 'ts_paint', 07:33:56 INFO - 'tpaint', 07:33:56 INFO - 'sessionrestore', 07:33:56 INFO - 'sessionrestore_no_auto_restore']}, 07:33:56 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:33:56 INFO - 'tests': ['a11yr', 07:33:56 INFO - 'ts_paint', 07:33:56 INFO - 'tpaint', 07:33:56 INFO - 'sessionrestore', 07:33:56 INFO - 'sessionrestore_no_auto_restore']}, 07:33:56 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:33:56 INFO - 'tests': ['a11yr', 07:33:56 INFO - 'ts_paint', 07:33:56 INFO - 'tpaint', 07:33:56 INFO - 'sessionrestore', 07:33:56 INFO - 'sessionrestore_no_auto_restore']}, 07:33:56 INFO - 'other_l64': {'tests': ['a11yr', 07:33:56 INFO - 'ts_paint', 07:33:56 INFO - 'tpaint', 07:33:56 INFO - 'sessionrestore', 07:33:56 INFO - 'sessionrestore_no_auto_restore']}, 07:33:56 INFO - 'other_nol64': {'tests': ['a11yr', 07:33:56 INFO - 'ts_paint', 07:33:56 INFO - 'tpaint', 07:33:56 INFO - 'sessionrestore', 07:33:56 INFO - 'sessionrestore_no_auto_restore']}, 07:33:56 INFO - 'svgr': {'tests': ['tsvgx', 07:33:56 INFO - 'tsvgr_opacity', 07:33:56 INFO - 'tart', 07:33:56 INFO - 'tscrollx', 07:33:56 INFO - 'cart']}, 07:33:56 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:33:56 INFO - 'tests': ['tsvgx', 07:33:56 INFO - 'tsvgr_opacity', 07:33:56 INFO - 'tart', 07:33:56 INFO - 'tscrollx', 07:33:56 INFO - 'cart']}, 07:33:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:33:56 INFO - 'tests': ['tp5o']}, 07:33:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:33:56 INFO - 'talos_options': ['--e10s'], 07:33:56 INFO - 'tests': ['tp5o']}, 07:33:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:33:56 INFO - 'talos_options': ['--xperf_path', 07:33:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:33:56 INFO - 'tests': ['tp5n']}, 07:33:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:33:56 INFO - 'talos_options': ['--e10s', 07:33:56 INFO - '--xperf_path', 07:33:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:33:56 INFO - 'tests': ['tp5n']}}, 07:33:56 INFO - 'talos.zip': {'path': '', 07:33:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:33:56 INFO - Running post-action listener: _resource_record_post_action 07:33:56 INFO - ##### 07:33:56 INFO - ##### Running create-virtualenv step. 07:33:56 INFO - ##### 07:33:56 INFO - Running pre-action listener: _resource_record_pre_action 07:33:56 INFO - Running main action method: create_virtualenv 07:33:56 INFO - Creating virtualenv /builds/slave/test/build/venv 07:33:56 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 07:33:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:33:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:33:56 INFO - Using real prefix '/usr' 07:33:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:33:57 INFO - Installing distribute.............................................................................................................................................................................................done. 07:34:01 INFO - Installing pip.................done. 07:34:01 INFO - Return code: 0 07:34:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:34:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:34:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:34:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f462e630c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a76c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2258900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229eb70>, '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 0x22efdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22f0250>, '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': '6d5287d839824eebc594b0c9000001d1-1447859883.469125-1934920036', '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 07:34:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:34:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:34:01 INFO - Using env: {'DISPLAY': ':0', 07:34:01 INFO - 'HOME': '/home/cltbld', 07:34:01 INFO - 'LANG': 'en_US.UTF-8', 07:34:01 INFO - 'LANGUAGE': 'en_US:en', 07:34:01 INFO - 'LOGNAME': 'cltbld', 07:34:01 INFO - 'MAIL': '/var/mail/cltbld', 07:34:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:01 INFO - 'MOZ_NO_REMOTE': '1', 07:34:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:34:01 INFO - 'NO_EM_RESTART': '1', 07:34:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:34:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:01 INFO - 'PWD': '/builds/slave/test', 07:34:01 INFO - 'SHELL': '/bin/bash', 07:34:01 INFO - 'SHLVL': '1', 07:34:01 INFO - 'TERM': 'linux', 07:34:01 INFO - 'TMOUT': '86400', 07:34:01 INFO - 'USER': 'cltbld', 07:34:01 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1447859883.469125-1934920036', 07:34:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:01 INFO - '_': '/tools/buildbot/bin/python'} 07:34:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:01 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:34:01 INFO - Cleaning up... 07:34:01 INFO - Return code: 0 07:34:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:34:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:34:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:34:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f462e630c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a76c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2258900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229eb70>, '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 0x22efdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22f0250>, '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': '6d5287d839824eebc594b0c9000001d1-1447859883.469125-1934920036', '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 07:34:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 07:34:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 07:34:01 INFO - Using env: {'DISPLAY': ':0', 07:34:01 INFO - 'HOME': '/home/cltbld', 07:34:01 INFO - 'LANG': 'en_US.UTF-8', 07:34:01 INFO - 'LANGUAGE': 'en_US:en', 07:34:01 INFO - 'LOGNAME': 'cltbld', 07:34:01 INFO - 'MAIL': '/var/mail/cltbld', 07:34:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:01 INFO - 'MOZ_NO_REMOTE': '1', 07:34:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:34:01 INFO - 'NO_EM_RESTART': '1', 07:34:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:34:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:01 INFO - 'PWD': '/builds/slave/test', 07:34:01 INFO - 'SHELL': '/bin/bash', 07:34:01 INFO - 'SHLVL': '1', 07:34:01 INFO - 'TERM': 'linux', 07:34:01 INFO - 'TMOUT': '86400', 07:34:01 INFO - 'USER': 'cltbld', 07:34:01 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1447859883.469125-1934920036', 07:34:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:01 INFO - '_': '/tools/buildbot/bin/python'} 07:34:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:01 INFO - Downloading/unpacking psutil>=0.7.1 07:34:01 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 07:34:01 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 07:34:01 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 07:34:01 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 07:34:01 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 07:34:01 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 07:34:03 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 07:34:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 07:34:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:34:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:34:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:34:03 INFO - Installing collected packages: psutil 07:34:03 INFO - Running setup.py install for psutil 07:34:03 INFO - building 'psutil._psutil_linux' extension 07:34:03 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 07:34:04 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:34:04 INFO - building 'psutil._psutil_posix' extension 07:34:04 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:34:04 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:34:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:34:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:34:04 INFO - Successfully installed psutil 07:34:04 INFO - Cleaning up... 07:34:04 INFO - Return code: 0 07:34:04 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:34:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:34:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:34:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f462e630c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a76c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2258900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229eb70>, '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 0x22efdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22f0250>, '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': '6d5287d839824eebc594b0c9000001d1-1447859883.469125-1934920036', '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 07:34:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 07:34:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 07:34:04 INFO - Using env: {'DISPLAY': ':0', 07:34:04 INFO - 'HOME': '/home/cltbld', 07:34:04 INFO - 'LANG': 'en_US.UTF-8', 07:34:04 INFO - 'LANGUAGE': 'en_US:en', 07:34:04 INFO - 'LOGNAME': 'cltbld', 07:34:04 INFO - 'MAIL': '/var/mail/cltbld', 07:34:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:04 INFO - 'MOZ_NO_REMOTE': '1', 07:34:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:34:04 INFO - 'NO_EM_RESTART': '1', 07:34:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:34:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:04 INFO - 'PWD': '/builds/slave/test', 07:34:04 INFO - 'SHELL': '/bin/bash', 07:34:04 INFO - 'SHLVL': '1', 07:34:04 INFO - 'TERM': 'linux', 07:34:04 INFO - 'TMOUT': '86400', 07:34:04 INFO - 'USER': 'cltbld', 07:34:04 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1447859883.469125-1934920036', 07:34:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:04 INFO - '_': '/tools/buildbot/bin/python'} 07:34:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:34:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:34:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:34:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:34:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:34:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:34:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:34:06 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:34:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 07:34:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:34:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:34:06 INFO - Installing collected packages: mozsystemmonitor 07:34:06 INFO - Running setup.py install for mozsystemmonitor 07:34:06 INFO - Successfully installed mozsystemmonitor 07:34:06 INFO - Cleaning up... 07:34:06 INFO - Return code: 0 07:34:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:34: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')]} 07:34:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34: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')]} 07:34:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f462e630c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a76c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2258900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229eb70>, '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 0x22efdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22f0250>, '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': '6d5287d839824eebc594b0c9000001d1-1447859883.469125-1934920036', '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 07:34:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:34:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:34:06 INFO - Using env: {'DISPLAY': ':0', 07:34:06 INFO - 'HOME': '/home/cltbld', 07:34:06 INFO - 'LANG': 'en_US.UTF-8', 07:34:06 INFO - 'LANGUAGE': 'en_US:en', 07:34:06 INFO - 'LOGNAME': 'cltbld', 07:34:06 INFO - 'MAIL': '/var/mail/cltbld', 07:34:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:06 INFO - 'MOZ_NO_REMOTE': '1', 07:34:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:34:06 INFO - 'NO_EM_RESTART': '1', 07:34:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:34:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:06 INFO - 'PWD': '/builds/slave/test', 07:34:06 INFO - 'SHELL': '/bin/bash', 07:34:06 INFO - 'SHLVL': '1', 07:34:06 INFO - 'TERM': 'linux', 07:34:06 INFO - 'TMOUT': '86400', 07:34:06 INFO - 'USER': 'cltbld', 07:34:06 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1447859883.469125-1934920036', 07:34:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:06 INFO - '_': '/tools/buildbot/bin/python'} 07:34:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:06 INFO - Downloading/unpacking blobuploader==1.2.4 07:34: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 07:34: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 07:34: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 07:34: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 07:34: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 07:34: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 07:34:08 INFO - Downloading blobuploader-1.2.4.tar.gz 07:34:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 07:34:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:34:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:34:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:34:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:34:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:34:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:34:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:34:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:34:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 07:34:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:34:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:34:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:34:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:34:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:34:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:34:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:34:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:34:08 INFO - Downloading docopt-0.6.1.tar.gz 07:34:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 07:34:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:34:08 INFO - Installing collected packages: blobuploader, requests, docopt 07:34:08 INFO - Running setup.py install for blobuploader 07:34:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:34:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:34:09 INFO - Running setup.py install for requests 07:34:09 INFO - Running setup.py install for docopt 07:34:09 INFO - Successfully installed blobuploader requests docopt 07:34:09 INFO - Cleaning up... 07:34:09 INFO - Return code: 0 07:34:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:34:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:34:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:34:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f462e630c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a76c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2258900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229eb70>, '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 0x22efdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22f0250>, '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': '6d5287d839824eebc594b0c9000001d1-1447859883.469125-1934920036', '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 07:34:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:34:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:34:09 INFO - Using env: {'DISPLAY': ':0', 07:34:09 INFO - 'HOME': '/home/cltbld', 07:34:09 INFO - 'LANG': 'en_US.UTF-8', 07:34:09 INFO - 'LANGUAGE': 'en_US:en', 07:34:09 INFO - 'LOGNAME': 'cltbld', 07:34:09 INFO - 'MAIL': '/var/mail/cltbld', 07:34:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:09 INFO - 'MOZ_NO_REMOTE': '1', 07:34:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:34:09 INFO - 'NO_EM_RESTART': '1', 07:34:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:34:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:09 INFO - 'PWD': '/builds/slave/test', 07:34:09 INFO - 'SHELL': '/bin/bash', 07:34:09 INFO - 'SHLVL': '1', 07:34:09 INFO - 'TERM': 'linux', 07:34:09 INFO - 'TMOUT': '86400', 07:34:09 INFO - 'USER': 'cltbld', 07:34:09 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1447859883.469125-1934920036', 07:34:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:09 INFO - '_': '/tools/buildbot/bin/python'} 07:34:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:34:09 INFO - Running setup.py (path:/tmp/pip-GYsRMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:34:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:34:09 INFO - Running setup.py (path:/tmp/pip-Tdhrxy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:34:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:34:09 INFO - Running setup.py (path:/tmp/pip-PooNln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:34:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:34:09 INFO - Running setup.py (path:/tmp/pip-oiAfj1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:34:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:34:10 INFO - Running setup.py (path:/tmp/pip-uWV5aw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:34:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:34:10 INFO - Running setup.py (path:/tmp/pip-djeRAt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:34:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:34:10 INFO - Running setup.py (path:/tmp/pip-8SIxzq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:34:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:34:10 INFO - Running setup.py (path:/tmp/pip-V_GTlG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:34:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:34:10 INFO - Running setup.py (path:/tmp/pip-8SCUY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:34:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:34:10 INFO - Running setup.py (path:/tmp/pip-Kv8KgN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:34:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:34:10 INFO - Running setup.py (path:/tmp/pip-WBM3Sl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:34:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:34:10 INFO - Running setup.py (path:/tmp/pip-hn5DYO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:34:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:34:10 INFO - Running setup.py (path:/tmp/pip-ZaxXli-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:34:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:34:10 INFO - Running setup.py (path:/tmp/pip-m8nMvh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:34:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:34:10 INFO - Running setup.py (path:/tmp/pip-UsZkkO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:34:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:34:10 INFO - Running setup.py (path:/tmp/pip-Ivb44w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:34:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:34:10 INFO - Running setup.py (path:/tmp/pip-LpGkyz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:34:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:34:10 INFO - Running setup.py install for manifestparser 07:34:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:34:11 INFO - Running setup.py install for mozcrash 07:34:11 INFO - Running setup.py install for mozdebug 07:34:11 INFO - Running setup.py install for mozdevice 07:34:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:34:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:34:11 INFO - Running setup.py install for mozfile 07:34:11 INFO - Running setup.py install for mozhttpd 07:34:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:34:11 INFO - Running setup.py install for mozinfo 07:34:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:34:11 INFO - Running setup.py install for mozInstall 07:34:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:34:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:34:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:34:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:34:11 INFO - Running setup.py install for mozleak 07:34:11 INFO - Running setup.py install for mozlog 07:34:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:34:11 INFO - Running setup.py install for moznetwork 07:34:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:34:12 INFO - Running setup.py install for mozprocess 07:34:12 INFO - Running setup.py install for mozprofile 07:34:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:34:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:34:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:34:12 INFO - Running setup.py install for mozrunner 07:34:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:34:12 INFO - Running setup.py install for mozscreenshot 07:34:12 INFO - Running setup.py install for moztest 07:34:12 INFO - Running setup.py install for mozversion 07:34:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:34:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:34:12 INFO - Cleaning up... 07:34:12 INFO - Return code: 0 07:34:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:34:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:34:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:34:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f462e630c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a76c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2258900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229eb70>, '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 0x22efdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22f0250>, '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': '6d5287d839824eebc594b0c9000001d1-1447859883.469125-1934920036', '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 07:34:12 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 07:34:12 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 07:34:12 INFO - Using env: {'DISPLAY': ':0', 07:34:12 INFO - 'HOME': '/home/cltbld', 07:34:12 INFO - 'LANG': 'en_US.UTF-8', 07:34:12 INFO - 'LANGUAGE': 'en_US:en', 07:34:12 INFO - 'LOGNAME': 'cltbld', 07:34:12 INFO - 'MAIL': '/var/mail/cltbld', 07:34:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:12 INFO - 'MOZ_NO_REMOTE': '1', 07:34:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:34:12 INFO - 'NO_EM_RESTART': '1', 07:34:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:34:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:12 INFO - 'PWD': '/builds/slave/test', 07:34:12 INFO - 'SHELL': '/bin/bash', 07:34:12 INFO - 'SHLVL': '1', 07:34:12 INFO - 'TERM': 'linux', 07:34:12 INFO - 'TMOUT': '86400', 07:34:12 INFO - 'USER': 'cltbld', 07:34:12 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1447859883.469125-1934920036', 07:34:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:12 INFO - '_': '/tools/buildbot/bin/python'} 07:34:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:34:12 INFO - Running setup.py (path:/tmp/pip-073Shn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:34:12 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)) 07:34:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:34:12 INFO - Running setup.py (path:/tmp/pip-ZZZMdg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:34:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:34:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:34:13 INFO - Running setup.py (path:/tmp/pip-o_WY3S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:34:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:34:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:34:13 INFO - Running setup.py (path:/tmp/pip-yxzMny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:34:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:34:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:34:13 INFO - Running setup.py (path:/tmp/pip-Tkl8Da-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:34:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:34:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:34:13 INFO - Running setup.py (path:/tmp/pip-D2WOY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:34:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:34:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:34:13 INFO - Running setup.py (path:/tmp/pip-1ZdRcH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:34:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:34:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:34:13 INFO - Running setup.py (path:/tmp/pip-Gpw3yF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:34:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:34:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:34:13 INFO - Running setup.py (path:/tmp/pip-2mMaT1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:34:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:34:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:34:13 INFO - Running setup.py (path:/tmp/pip-9cUpUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:34:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:34:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:34:13 INFO - Running setup.py (path:/tmp/pip-hJ2sta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:34:13 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)) 07:34:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:34:13 INFO - Running setup.py (path:/tmp/pip-yAO8tS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:34:13 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)) 07:34:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:34:13 INFO - Running setup.py (path:/tmp/pip-QKwmmn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:34:13 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)) 07:34:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:34:13 INFO - Running setup.py (path:/tmp/pip-CC2sRU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:34:13 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)) 07:34:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:34:13 INFO - Running setup.py (path:/tmp/pip-uQeLvB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:34:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:34:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:34:14 INFO - Running setup.py (path:/tmp/pip-Et7EOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:34:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:34:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:34:14 INFO - Running setup.py (path:/tmp/pip-W4M2WO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:34:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:34:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:34:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:34:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:34:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:34:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:34:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:34:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:34:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:34:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:34:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:34:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:34:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:34:15 INFO - Downloading blessings-1.5.1.tar.gz 07:34:15 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 07:34:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:34:15 INFO - Installing collected packages: blessings 07:34:15 INFO - Running setup.py install for blessings 07:34:16 INFO - Successfully installed blessings 07:34:16 INFO - Cleaning up... 07:34:16 INFO - Return code: 0 07:34:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:34:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:34:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:34:16 INFO - Reading from file tmpfile_stdout 07:34:16 INFO - Current package versions: 07:34:16 INFO - argparse == 1.2.1 07:34:16 INFO - blessings == 1.5.1 07:34:16 INFO - blobuploader == 1.2.4 07:34:16 INFO - docopt == 0.6.1 07:34:16 INFO - manifestparser == 1.1 07:34:16 INFO - mozInstall == 1.12 07:34:16 INFO - mozcrash == 0.16 07:34:16 INFO - mozdebug == 0.1 07:34:16 INFO - mozdevice == 0.47 07:34:16 INFO - mozfile == 1.2 07:34:16 INFO - mozhttpd == 0.7 07:34:16 INFO - mozinfo == 0.9 07:34:16 INFO - mozleak == 0.1 07:34:16 INFO - mozlog == 3.0 07:34:16 INFO - moznetwork == 0.27 07:34:16 INFO - mozprocess == 0.22 07:34:16 INFO - mozprofile == 0.27 07:34:16 INFO - mozrunner == 6.11 07:34:16 INFO - mozscreenshot == 0.1 07:34:16 INFO - mozsystemmonitor == 0.0 07:34:16 INFO - moztest == 0.7 07:34:16 INFO - mozversion == 1.4 07:34:16 INFO - psutil == 3.1.1 07:34:16 INFO - requests == 1.2.3 07:34:16 INFO - wsgiref == 0.1.2 07:34:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:34:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:34:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:34:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f462e630c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a76c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2258900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229eb70>, '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 0x22efdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22f0250>, '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': '6d5287d839824eebc594b0c9000001d1-1447859883.469125-1934920036', '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 07:34:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:34:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:34:16 INFO - Using env: {'DISPLAY': ':0', 07:34:16 INFO - 'HOME': '/home/cltbld', 07:34:16 INFO - 'LANG': 'en_US.UTF-8', 07:34:16 INFO - 'LANGUAGE': 'en_US:en', 07:34:16 INFO - 'LOGNAME': 'cltbld', 07:34:16 INFO - 'MAIL': '/var/mail/cltbld', 07:34:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:16 INFO - 'MOZ_NO_REMOTE': '1', 07:34:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:34:16 INFO - 'NO_EM_RESTART': '1', 07:34:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:34:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:16 INFO - 'PWD': '/builds/slave/test', 07:34:16 INFO - 'SHELL': '/bin/bash', 07:34:16 INFO - 'SHLVL': '1', 07:34:16 INFO - 'TERM': 'linux', 07:34:16 INFO - 'TMOUT': '86400', 07:34:16 INFO - 'USER': 'cltbld', 07:34:16 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1447859883.469125-1934920036', 07:34:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:16 INFO - '_': '/tools/buildbot/bin/python'} 07:34:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:34:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:34:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:34:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:34:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:34:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:34:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:34:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:34:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:34:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:34:16 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:34:16 INFO - Cleaning up... 07:34:16 INFO - Return code: 0 07:34:16 INFO - Running post-action listener: _resource_record_post_action 07:34:16 INFO - Running post-action listener: _start_resource_monitoring 07:34:16 INFO - Starting resource monitoring. 07:34:16 INFO - ##### 07:34:16 INFO - ##### Running install step. 07:34:16 INFO - ##### 07:34:16 INFO - Running pre-action listener: _resource_record_pre_action 07:34:16 INFO - Running main action method: install 07:34:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:34:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:34:16 INFO - Reading from file tmpfile_stdout 07:34:16 INFO - Detecting whether we're running mozinstall >=1.0... 07:34:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:34:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:34:16 INFO - Reading from file tmpfile_stdout 07:34:16 INFO - Output received: 07:34:16 INFO - Usage: mozinstall [options] installer 07:34:16 INFO - Options: 07:34:16 INFO - -h, --help show this help message and exit 07:34:16 INFO - -d DEST, --destination=DEST 07:34:16 INFO - Directory to install application into. [default: 07:34:16 INFO - "/builds/slave/test"] 07:34:16 INFO - --app=APP Application being installed. [default: firefox] 07:34:16 INFO - mkdir: /builds/slave/test/build/application 07:34:16 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'] 07:34:16 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 07:34:30 INFO - Reading from file tmpfile_stdout 07:34:30 INFO - Output received: 07:34:30 INFO - /builds/slave/test/build/application/firefox/firefox 07:34:30 INFO - Running post-action listener: _resource_record_post_action 07:34:30 INFO - ##### 07:34:30 INFO - ##### Running run-tests step. 07:34:30 INFO - ##### 07:34:30 INFO - Running pre-action listener: _resource_record_pre_action 07:34:30 INFO - Running main action method: run_tests 07:34:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:34:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:34:30 INFO - Python 2.7.3 07:34:30 INFO - Return code: 0 07:34:30 INFO - grabbing minidump binary from tooltool 07:34:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:34:30 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 0x229eb70>, '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 0x22efdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22f0250>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:34:30 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 07:34:30 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 07:34:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:34:30 INFO - Return code: 0 07:34:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:34:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:34:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:34:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:34:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:34:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HSYjftOxQF-CX1F5o09Qog/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost'] in /builds/slave/test/build 07:34:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HSYjftOxQF-CX1F5o09Qog/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --webServer localhost 07:34:30 INFO - Using env: {'DISPLAY': ':0', 07:34:30 INFO - 'HOME': '/home/cltbld', 07:34:30 INFO - 'LANG': 'en_US.UTF-8', 07:34:30 INFO - 'LANGUAGE': 'en_US:en', 07:34:30 INFO - 'LOGNAME': 'cltbld', 07:34:30 INFO - 'MAIL': '/var/mail/cltbld', 07:34:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:34:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:34:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:30 INFO - 'MOZ_NO_REMOTE': '1', 07:34:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:34:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:34:30 INFO - 'NO_EM_RESTART': '1', 07:34:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:34:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:30 INFO - 'PWD': '/builds/slave/test', 07:34:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:34:30 INFO - 'SHELL': '/bin/bash', 07:34:30 INFO - 'SHLVL': '1', 07:34:30 INFO - 'TERM': 'linux', 07:34:30 INFO - 'TMOUT': '86400', 07:34:30 INFO - 'USER': 'cltbld', 07:34:30 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1447859883.469125-1934920036', 07:34:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:30 INFO - '_': '/tools/buildbot/bin/python'} 07:34:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HSYjftOxQF-CX1F5o09Qog/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost'] with output_timeout 3600 07:34:31 INFO - mozversion INFO | application_buildid: 20151118062325 07:34:31 INFO - mozversion INFO | application_changeset: 44f58c7fc121e68854da500798ef84c0f432a32a 07:34:31 INFO - mozversion INFO | application_display_name: Nightly 07:34:31 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:34:31 INFO - mozversion INFO | application_name: Firefox 07:34:31 INFO - mozversion INFO | application_remotingname: firefox 07:34:31 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 07:34:31 INFO - mozversion INFO | application_vendor: Mozilla 07:34:31 INFO - mozversion INFO | application_version: 45.0a1 07:34:31 INFO - mozversion INFO | platform_buildid: 20151118062325 07:34:31 INFO - mozversion INFO | platform_changeset: 44f58c7fc121e68854da500798ef84c0f432a32a 07:34:31 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 07:34:31 INFO - mozversion INFO | platform_version: 45.0a1 07:34:31 INFO - 2015-11-18 07:34:31,106 DEBUG : using testdate: 1447860871 07:34:31 INFO - 2015-11-18 07:34:31,106 DEBUG : actual date: 1447860871 07:34:31 INFO - 2015-11-18 07:34:31,115 INFO : starting webserver on 'localhost:38171' 07:34:31 INFO - 2015-11-18 07:34:31,116 INFO : Starting test suite talos-linux64-ix-018 07:34:31 INFO - 2015-11-18 07:34:31,116 INFO : Starting test dromaeo_css 07:34:31 INFO - 2015-11-18 07:34:31,116 DEBUG : operating with platform_type : linux_ 07:34:31 INFO - 2015-11-18 07:34:31,116 INFO : Initialising browser for dromaeo_css test... 07:34:31 INFO - 2015-11-18 07:34:31,131 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWr6JZu/profile http://localhost:38171/getInfo.html 07:34:35 INFO - 2015-11-18 07:34:35,677 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:34:35 INFO - 2015-11-18 07:34:35,677 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:34:35 INFO - 2015-11-18 07:34:35,677 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:34:35 INFO - 2015-11-18 07:34:35,677 DEBUG : BROWSER_OUTPUT: __metrics 07:34:35 INFO - 2015-11-18 07:34:35,943 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:34:37 INFO - 2015-11-18 07:34:37,700 INFO : Browser initialized. 07:34:37 INFO - 2015-11-18 07:34:37,701 INFO : Running cycle 1/1 for dromaeo_css test... 07:34:37 INFO - 2015-11-18 07:34:37,701 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWr6JZu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:34:49 INFO - 2015-11-18 07:34:49,577 DEBUG : BROWSER_OUTPUT: RSS: Main: 140365824 07:34:49 INFO - 2015-11-18 07:34:49,577 DEBUG : BROWSER_OUTPUT: 07:35:40 INFO - 2015-11-18 07:35:40,934 DEBUG : BROWSER_OUTPUT: 1447860940931 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] 07:37:52 INFO - 2015-11-18 07:37:52,781 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38171/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38171/tests/dromaeo/cssquery-ext.html) 07:37:53 INFO - 2015-11-18 07:37:53,897 DEBUG : BROWSER_OUTPUT: RSS: Main: 250417152 07:37:53 INFO - 2015-11-18 07:37:53,897 DEBUG : BROWSER_OUTPUT: 07:40:56 INFO - 2015-11-18 07:40:56,365 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38171/tests/dromaeo/cssquery-ext.html (next: http://localhost:38171/tests/dromaeo/cssquery-jquery.html) 07:40:56 INFO - 2015-11-18 07:40:56,931 DEBUG : BROWSER_OUTPUT: RSS: Main: 223174656 07:40:56 INFO - 2015-11-18 07:40:56,931 DEBUG : BROWSER_OUTPUT: 07:43:59 INFO - 2015-11-18 07:43:59,053 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38171/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38171/tests/dromaeo/cssquery-mootools.html) 07:43:59 INFO - 2015-11-18 07:43:59,623 DEBUG : BROWSER_OUTPUT: RSS: Main: 208379904 07:43:59 INFO - 2015-11-18 07:43:59,623 DEBUG : BROWSER_OUTPUT: 07:47:01 INFO - 2015-11-18 07:47:01,601 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38171/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38171/tests/dromaeo/cssquery-prototype.html) 07:47:02 INFO - 2015-11-18 07:47:02,182 DEBUG : BROWSER_OUTPUT: RSS: Main: 205729792 07:47:02 INFO - 2015-11-18 07:47:02,182 DEBUG : BROWSER_OUTPUT: 07:50:04 INFO - 2015-11-18 07:50:04,951 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38171/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38171/tests/dromaeo/cssquery-yui.html) 07:50:05 INFO - 2015-11-18 07:50:05,532 DEBUG : BROWSER_OUTPUT: RSS: Main: 207904768 07:50:05 INFO - 2015-11-18 07:50:05,532 DEBUG : BROWSER_OUTPUT: 07:53:08 INFO - 2015-11-18 07:53:08,032 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38171/tests/dromaeo/cssquery-yui.html (next: http://localhost:38171/tests/dromaeo/cssquery-dojo.html) 07:53:08 INFO - 2015-11-18 07:53:08,290 DEBUG : BROWSER_OUTPUT: RSS: Main: 250585088 07:53:08 INFO - 2015-11-18 07:53:08,291 DEBUG : BROWSER_OUTPUT: 07:53:08 INFO - 2015-11-18 07:53:08,291 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:53:08 INFO - 2015-11-18 07:53:08,291 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:53:08 INFO - 2015-11-18 07:53:08,291 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:53:08 INFO - 2015-11-18 07:53:08,291 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:53:08 INFO - 2015-11-18 07:53:08,291 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2680.557707978183;2739.1508632323967;2776.4724702306567;2782.012385603111;2789.679186893508;4562.178807814592;4656.161890859644;4693.483716791159;4704.952950470499;4739.597134243589;4561.703489273195;4670.743109128996;4686.156491831469;4768.809247630091;4783.067301876135;4344.066025804452;4347.434833471644;4360.825566977317;4363.650907927358;4389.648828093745;4113.218488487193;4471.575200355961;4492.7528985905765;4524.660650451213;4525.728456292633;4146.91706165878;4235.597618226295;4248.299030659938;4253.447051883235;4269.103488267437;4312.805923733408;4314.094040251551;4323.329883868006;4344.218040752663;4367.672424568138;4074.0833312504747;4173.603507666767;4275.978620106911;4279.957200427987;4313.137372525507;4575.839845605421;4655.51117132703;4661.394018777572;4666.136764698542;4688.671792974493;5047.671901326402;5059.266406371093;5059.671121377099;5074.4671809460215;5104.64267501275;4847.612191024745;4959.156943319645;4968.056069346812;5066.113430149709;5076.466970968069;4606.378138951266;4684.929726054112;4691.272852707768;4727.834525791615;4750.097481478508;5232.659877107976;5236.450172731885;5237.8428647140645;5287.048331300326;5289.259503669489;4751.216049351888;4864.318995340655;5024.296598476216;5027.82402615914;5030.974845125751;4864.80540778372;5049.343585333883;5111.488851114933;5115.820946266937;5157.174852023658;4987.80048798044;4988.276699878497;5005.099082165172;5023.070731914608;5029.2958985742025;4800.783964721596;4907;4973.42805577356;4980.77586508608;4990.500949905053;4164.604362585549;4195.811188496525;4239.0885959518855;4245.066085461193;4280.058387154821;3700.296943580711;3718.2749363874327;3744.1388480649603;3744.737868349244;3767.698584113264;4149.91700165995;4247.5964783345535;4391.3193455014525;4402.25161722508;4428.490723566767;4937.580305674058;5066.544011039025;5173.456787037382;5182.97408512955;5224.608154388436;4429.75636339998;4461.843835465743;4461.977690111528;4467.83042394015;4489.9551004490195;4307.289297265978;4415.227335216325;4609.216433206363;4610.9308360374625;4637.234856248681;4717.386739723883;4771.212749896228;4812.855614331575;4823.1800593899825;4843.450095969256;4916.3362946001835;4918.631102667386;4923.520063567797;4959.801607935642;4966.130927087817;4600.88497787558;4675.485696573306;4676.251799712166;4696.8590942271785;4722.905541889212;4867.878303042452;4880.511948805091;4893.926591101065;4965.751712414437;4973.179425394769;5052.873678158076;5071.619628527949;5077.644564880423;5080.339555857715;5104.872378190426;4873.049755297683;4887.144749668722;4890.510948905081;4906.067847109038;4922.064807686528;4632.25883858581;4746.62027037843;4749.097671442415;4753.334533165429;4825.927611085766;4848.369711937426;4912.95087049125;4925.433575138905;4925.605951523941;4950.356453661001;5014.799408023784;5046.268291097844;5054.494550544916;5055.16589762685;5095.363079615048;4496.370508128799;4624.838130665411;4629.884252893705;4769.523047695203;4939.975300123477 07:53:08 INFO - 2015-11-18 07:53:08,291 DEBUG : BROWSER_OUTPUT: |1;ext.html;563.8590352411894;574.9108888122342;577.1948132355365;579.652208674795;582.1733138942701;26538.33654158647;27164.592531112048;27189.184324470272;27211.183664490098;33532.49701254483;39796.60203397965;40242.59757402425;40285.7985710071;40320.79839600805;40361.19277614453;7986.201379862011;8153.551554664491;8158.5104893706275;8160.102388737234;8161.6735330587;6930.237673855897;7071.929280707179;7071.964640176818;7073.009778630996;7956;7063.046488724033;10287.434191119522;10645.84031239532;10650;10654.360738355685;10109.090181883628;10227.590896364136;10230.693079207636;10234.385936843739;10244.129249013842;7132;7332.78001659951;9898.257630677655;10032.398056116657;10052.597896084148;40769.592304076876;41528.79235603803;41765.37351939723;41787.7910610448;41794.79102604498;2869.5982562441277;2943.67619561848;2964.9851750741323;3589.958911915541;3675.3384390809642;26007.219783406526;27354.589681154797;27690.169294921183;28089;28367.716322836714;3034.408290383376;3042.5284080967485;3098.148009297439;3113.081640915935;3176.777625566211;188856;188976;189055;190095.04952475286;190274;51266.48733512692;51376;51443;51587.74206128946;51630.48369516332;54130.18804717853;54275.45724542704;54333.185002225;54367.45632543703;54384;11766.823497647541;12017;12089.516419343303;12103.515859365527;12129.454174562166;9242.260619150451;9309.441433513875;9314.627414903329;9314.813703725888;9385.671501497414;17905.7314140288;18236.27054917815;18369.53043756496;18398.356057537923;18438.631227375376;6889.896651550231;7149.964250178716;7258.927410725931;7259.89110163348;7303.342699156995;792.2117493094293;845.5307304445969;866.4974314897345;910.094456016268;988.8170688422521;25804.483910321687;26323.47353052928;26942.730572694414;26963.460730785668;28070.2982425441;816.9142240064826;857.1728282207699;862.7713655881197;906.6373450619805;918.9678361257323;12759.298238596966;12883.227006379648;13026.348682565835;13095;13135.934320328337;256540;260367;260550;260864;261045;39466;40602.390964135564;42988.78505607452;43901.341479877825;43919.78040109779;1119.6025410979148;1134.5518520184646;1139.168407062832;1139.3676509537286;1146.8509093817918;23092;24458.26625201247;25811.225663230132;26059;26469.735302646728;36735.265294694495;37080.81459592685;37082.443763343035;37161.25677486381;37200.6279937208;172953;174571;174600.12699936418;174694;174778.12610937373;27718.307042324104;28289.858550707115;28299.71700283053;28317.292067698472;28357.858210708815;38389.80805096068;39238;39242.80378598203;39419;39719;32194.449439548906;33188.83405582957;33294.16764580905;33917;34027.65972340344;33117.337653246315;33615.83192084024;33706.325873482885;33753.66246337604;33927.491087633214;33456.49815252822;33649.83175084109;33709.662903370656;33937;34006.82996585001;29978;30062.54906176453;30389.39221215519;30555.54166687457;30592;23570.764292356856;23721.52556948886;23914.009415829067;24000.87999559991;24138.637920430858 07:53:08 INFO - 2015-11-18 07:53:08,292 DEBUG : BROWSER_OUTPUT: |2;jquery.html;304.1210900497561;304.3092180749698;310.64586371536444;311.8643390125294;312.5062401405779;12393.318367489806;12824;15921.36314547418;16265.51203463895;16451.588710282234;12539.435725392357;15024.924875375607;15768.211589420513;16297;16308.51074467765;4873.049755297719;4888.902221955567;4974.77613507393;4975.3532040834825;4980.6762560433635;3517.26137511123;3617.7105831533413;4842.66101372904;4886.657933944625;5417.972910135444;5481.616286859921;5507.697076660782;5531.806386776464;5533.391326954052;5540.36285827129;4399.912001759979;4515.932261016087;4520.95479045212;5493.450654934514;5499.422560631137;3892.2020985697864;3898.5126859142606;3903.316919539098;3903.5706072332023;3905.1799122184375;11648.475818588184;11720.648380548597;11991;11992.70018249542;12000.759984800256;1686.5005114387573;1703.6081701208668;1733.4366330942494;1814.4012475882928;1820.7359932809668;8454.704085357045;8581.056083830774;8646.567671616456;8652.567371631394;8847.77880552985;1530.670905755268;1531.058399084555;1539.168848821635;1588.6663800601773;1605.0209372282898;51713;52635.73682131603;52651.47348526542;52669.2099618506;53316.20025699618;6068.302145253264;6088.452039316483;6089.330173680892;6107.358727333655;6179.567430279837;7057.682404291819;7119.750808721774;7123.2520585338825;7131.8573628528175;7145.999560061596;4488.326750987313;4522.841700540465;4574.222382195035;4597.517260687647;4604.309353596987;4560.270356742905;4561.657875659339;4576.199165146086;4586.610138138296;4589.816407343736;2762.986185069102;2780.652418447694;2783.248522898806;2796.1052463211986;2799.552071668564;1003.859459675646;1010.7271036820017;1041.8645576075062;1062.7768168684663;2758.3655759175504;378.25295042291253;386.04261431649667;394.5994815262511;409.25107054090944;436.3236982676838;10252.436116013541;10574.841377379345;10579.31234469757;10616.469176541143;10633.5214915329;368.9538807649044;393.5670762161657;400.0618549501473;429.49105310207506;438.75210506063974;5148.099082660519;5389.622726409192;5467;5477.315335583052;5689.686134445417;475298;479061;483711;492648;495966;63805.68097159485;66353;66675.66662166755;66966.330336696;67210;460.298045480638;469.7486844538224;469.96945198561986;470.52712024415246;471.6698311182118;9392.107749763762;9431.858522122311;9443.716688499357;9491.66779162726;9569.995150509096;30536.236594085327;31405.842970785;32617.206053667276;32869.17827054247;33555.496667549516;38687.41968870525;39226.6077339223;39558.2088358237;41077.79461102675;41290;5860.267466566679;6009.399060093956;6032.245969253843;6036.517078633611;6040.36576159497;10567.101796347397;10649.307794993301;10753.354798711789;10822.134229261483;10853;9561.282903782383;9584.76038099053;9655.131038206595;9677.177439917687;9758.951205243928;9105.681301154427;9149.31380146505;9191.35660503785;9274;9509.239260859253;8323.375746819134;8554.786130346542;9310.487923164292;9412;9563.569639366384;5826.184334193301;5916.437938395846;5927.407259274038;5934.169216309634;5985.042393217064;9061.093890610886;9267.073292670679;9267.397619154734;9462.574184161867;9465.384749991228 07:53:08 INFO - 2015-11-18 07:53:08,293 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1397.2734178227329;1590.5864475236438;1617.2398972482936;1647.4645740134456;1658.1294820219384;5663.207150998864;6274.215723034621;6401.423871851533;6436.195475565542;6447.290798012221;6571.047198156264;6621;6651.235107962586;6652.101966234569;6654.168228971379;1587.8253392126858;1647.3081305851572;1944.795796441371;1963.6072785442898;1965.636357273909;1926.749522562065;1969.7439332886704;1979.980200197994;1981.187713037655;1981.38577041117;1894.1097684088525;1917.5302050997525;1921.8750781199246;1952.6582848001615;1955.6968669856124;1913.2155816115396;1924.422673198035;1927.7493925789558;1931.1020375525377;1931.3433432632833;1965.5282732144183;2020.979790202094;2021.9898900505402;2022.4741567192636;2023;6707.3628005339415;6790.898136527907;6793.184817821843;6794.388505034571;6797.864042719118;3827.7703337799544;3900.5319361676497;3902.5316961964463;3914.7651140931634;3926.8429262829454;2590.6502622146145;2656.1102030819507;2702.9864850675817;2728.45430913818;2762.6270453488723;726.742006587659;737.7381029734474;755.5806527377304;837.0374069819695;845.9154084591553;8900.37697361185;8933.19601235892;8934.776630584221;8941.910580894173;8966.551672416419;3668.3947148720695;3686.3733165361955;3732.496113024761;3747.2880152770886;3751.643593858579;7916.6041697916025;7919.485233459806;7925.603719813987;7931.167227441036;7931.682732690743;3984.322665146932;3988.082740969593;3996.260691771973;4002.3196056670436;4012.9799351003057;3608.350496910529;3609.3503169429755;3609.5307610011055;3611.5485564304463;3613.638636136365;2853.5576985566854;2902.9274268143467;3224.0489055728617;3226.0966929259844;3269.7711160218555;999.7400675824338;1022.3763504262394;1026.9178465722725;1032.948352582368;1051.395447617623;926.9756918604979;1076.2950267574595;1105.6406667832987;1136.085451211766;1136.193302755053;6496.123023391781;6536.600967496875;6554.180727409074;6555.8361040973405;6567.376099270562;993.2550587059706;1011.261778901406;1013.0780989299849;1017.3743147963949;1028.6142696488816;5014.423341315723;5098.974505127525;5111.258867464197;5113.565346945476;5116.846494605168;7897.1707970662255;7995.880061799077;8083.585372559778;8087.878681819778;8162.591870406574;8025.799355016171;8093.919060809434;8101.473404228706;8155.632996515171;8179.222973817477;6387.648679322682;6439.613623182624;6452.161219041494;6486.643234622046;6496.642684652389;5898.528117750484;5964.493018093511;6000.549958753199;6013.128096426081;6046.2139921809885;7204.135503739585;7242.13094428672;7280.271972802678;7302.196758356683;7328.670209840677;7302.56184628924;7365;7365.447591430557;7475.775726728207;7499.737509187153;5997.820065398045;6094.451499365078;6103.176071230505;6118.990366589463;6135.233095863017;5356.250124982584;5388.946110538845;6578.210614726264;6619.966900165661;6628.204615446178;5994.07091900756;6007.849803754941;6043.425874541911;6087.391260873877;6125.081237814364;5947.226860508106;5947.345791962967;6001.279846418458;6016.338202797601;6019.638821670714;5892.292924849045;5926.614770040106;5934.1988831508925;5936.643801371932;5939.10913362999;5403.459654034722;5475.425080366664;5664.150377443417;5665.886682266414;5668.63153895012;5668;5693.829185124453;5712.600117991867;5713.714314284186;5715.142728590745 07:53:08 INFO - 2015-11-18 07:53:08,293 DEBUG : BROWSER_OUTPUT: |4;prototype.html;271.6156638356725;275.42986018940786;275.77248769764947;277.56699548704023;280.4643131618609;5291.1798671205925;5367.812126575571;5392.137258038714;5398.946010539898;5422.728863556821;5214.973925130378;5388.110961691326;5401.78392864285;5403.70279634621;5422.213779002042;4108.917821643573;4112.485939257593;4116.670666346685;4117.608827161415;4128.8348466061325;3897.7661340319673;3988.1824226033596;4023.436718859362;4109.609587089237;4112.568180341066;4082.5713300103507;4093.406456063869;4096.446979657752;4099.979500102495;4101.5488296287385;4063.0654949361515;4064.9390259146135;4073.429719839225;4080.489938757655;4085.5914408558906;3537.663921927413;3537.823108844573;3537.964620353789;3544.220271540257;3544.805035723034;5107.744612769384;5194.818181363634;5238.633295669305;5241.606879484016;5247.16045432729;4710.081534100852;4716.50476699945;4716.669833111683;4719.244920812688;4724.976375118103;5666.914996275059;5670;5670.06443936754;5672.064109421982;5673.205751194836;3865.4781604483314;3876.089119057019;3876.612338766129;3877.224555088965;3877.5346958365176;5494.890102197974;5608.074667679869;5964.135200395918;5973.074173503114;5979.19280897082;3842.7886466244067;3951.9527325258828;3955.8132560231816;3956.5647778744315;3957.5448823385677;4014.5583985762128;4024.4566983457444;4027.4160246764054;4029.91940161201;4032.9798351008058;4646.163690535668;4657;4657.5575320344515;4660.324252983366;4667.206574882278;5668.149777533403;5676.347220069662;5680.857978550486;5681.403452637496;5681.545476361881;1328.3955800110925;1376.7728324826492;1377;1377.9862201378057;1378.7793952967677;890.1988210610373;902.9593668284942;907.9636814527477;909.1544863277084;919.2186641354795;4958.107540642719;4971.1549036663855;4977.9751101244265;4982;4986.052649996562;5858.238429004287;5864.501517370986;5871.911921321183;5875.6180848245585;5877.265341832271;4835.0571638530855;4869.196582563908;4977.427595826454;4982.750862456863;4985.675931064469;3141.858616362269;3159.0838656789274;3163.873445062218;3167.0815463515783;3170.0648308748973;5611.298587676541;5631.943680563142;5644.6613203207935;5646.576506761927;5651.208830763697;5957.910631340534;6091.725872335755;6113.541484388688;6117.816465506042;6132.478739307119;5643.266375371176;5645.266115405053;5661.150827375926;5664.291963504562;5668.433156684381;5940.376260492586;5948.048312270016;5951.1073338999495;5963.105534169909;5973.313068997121;5702.144678298288;5829;5833.416658334133;5836.270466191726;5839.416058394127;5634.943650563442;5638.9436105638415;5647.745851436777;5648.745806438638;5656.915146272891;3874.205787813548;3907.335752922067;3908.1792823506244;3914.0801911551334;3915.0799562103452;5938.376470470538;5943.019401798655;5946.286445626552;5946.345901950868;5946.762129514771;5571;5675.205471234113;5690.743916523684;5694.572907032072;5697.943020569741;5649.689267090185;5651.180578816131;5652.434756524314;5653.180288858175;5662.178984047372;5563.443655634404;5567.916481252703;5569.637973531708;5576.470235327637;5588.888222235614;5623.971880140573;5730.541556675373;5739.5695322850115;5740.253767010262;5745.683987380567;5522.282103326542;5553.333599967868;5568.276124103841;5573.909783831064;5577.191307260344 07:53:08 INFO - 2015-11-18 07:53:08,294 DEBUG : BROWSER_OUTPUT: |5;yui.html;620.857202843346;721.967511461984;745.7613563659628;753.472569201559;766.4902839611663;11577.53689852406;11727.237729547584;11736.941315293423;11748.530058797638;11778.646640600775;11815;12049.277043377404;12135.696607584814;12141.817872731915;12145.08911831614;609.2658346692248;616.6207782213951;779.0612312163843;780.4302858912997;797.4696826610326;791.0586402181415;800.4076983032572;800.7998000499875;803.2369249213242;803.6704950970103;632.8892443822335;762.6834863531656;816.5264146794874;839.7690635075342;840.1472505407016;640.6188317950812;790.9881351779728;801.5711594297081;802.5385403393072;803.5419810707899;601.5518438763106;603.4599033864666;603.6136872401667;603.9063945088518;603.9486643635296;12021.218620789621;12285.754284914341;12299.139060265785;12328.19866708661;12332.383380830923;11054.613088541862;11392.658220253406;11490.482928268248;11923.403829808562;12510.061745369134;9947.303688741791;9968.302218844683;10006.69979900604;10014;10040.246981476346;3172.4289627866974;3224.6614105518815;3228.3059142284287;3285.1458620758535;3291.424000799874;40976.180476390604;41028.589714102774;41028.589714102774;41137.17725645471;41284.79357603223;9635.22918166545;9641.132298093065;9817.312788104764;9818.067283608047;9844.261680374;10795.46022698862;10914.617988370368;10925.890741092646;10929.672109836718;10930.398828064534;5269.077911365495;5329.467053294717;5530.6128570999645;5590.440955904377;5595.776168953278;3336.132605522582;3393.372226138123;3408.2672225471147;3409.9147521312166;3410.1474631342167;2498.375406148463;2601;2603.8177327586886;2608.960865587018;2611.3732704150866;397.715633322176;400.74953154278575;402.0692097793598;402.94157347184495;404.561051259381;408.8609872643256;451.7238800388914;463.96998662968156;479.11124863378626;515.9593806495302;7478.102627684604;7549.433792465587;7562.697492100255;7599.430042746816;7922.207779222032;386.5805600922974;429.93550967355145;569.7663957777374;609.4910749524197;609.5428428678491;3785.4511095890944;3789.696824254053;3885.1452680410266;3914.8042597869994;3954.6045395460224;51808;52511.212331815055;52602.73698631483;52604;52783.472165278625;42536.78731606322;42764.57235427668;43505.12989740187;43527.78236108799;45328.773356133664;38851.41722874159;39423.408648869714;41324.38013429801;41693;41747.7912610435;8166.795830104057;8243.093259741303;8265.297449716842;8326.45878017927;8401.285890699115;32306.19234519062;32615;32951.17622059468;33025.33949321048;33240;40353.19293614053;41442;41848;41948.161036779704;42288.577114228465;6674.299198584079;6763.323667633197;6909.827254318682;7304.926950730637;7413.147488038944;11647.184697071123;11840.70398240051;11957.581484647995;11989.1008174389;12413.93793031029;9999.450030248407;10491.422971736627;10599.15206783471;10731.356118632906;10880.782384352111;10614.097801686634;10642.308249963728;10707.304025238334;10746.301490403099;10904.781904362027;7856.968986433153;9978.650747223812;11093.33439993603;11373.090152787923;11459.656210313371;8996.64013439455;9186.908130918606;9335.206507446672;9538.475383853955;9641.325107242426;9327.533623318943;9658.613655453702;9847.655332063343;9858.359206651545;9860.26048046385 07:53:08 INFO - 2015-11-18 07:53:08,294 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:53:08 INFO - 2015-11-18 07:53:08,294 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:53:08 INFO - 2015-11-18 07:53:08,294 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,908 07:53:08 INFO - 2015-11-18 07:53:08,294 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:53:08 INFO - 2015-11-18 07:53:08,294 DEBUG : BROWSER_OUTPUT: __startTimestamp1447861988284__endTimestamp 07:53:08 INFO - 2015-11-18 07:53:08,295 DEBUG : BROWSER_OUTPUT: 07:53:08 INFO - 2015-11-18 07:53:08,295 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:53:08 INFO - 2015-11-18 07:53:08,295 DEBUG : BROWSER_OUTPUT: Number of tests: 6 07:53:08 INFO - 2015-11-18 07:53:08,295 DEBUG : BROWSER_OUTPUT: 07:53:08 INFO - 2015-11-18 07:53:08,295 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4647.05 Median:4746.62 stddev:478.98 (10.1%) stddev-sans-first:454.93 07:53:08 INFO - 2015-11-18 07:53:08,295 DEBUG : BROWSER_OUTPUT: Values: 2680.6 2739.2 2776.5 2782.0 2789.7 4562.2 4656.2 4693.5 4705.0 4739.6 4561.7 4670.7 4686.2 4768.8 4783.1 4344.1 4347.4 4360.8 4363.7 4389.6 4113.2 4471.6 4492.8 4524.7 4525.7 4146.9 4235.6 4248.3 4253.4 4269.1 4312.8 4314.1 4323.3 4344.2 4367.7 4074.1 4173.6 4276.0 4280.0 4313.1 4575.8 4655.5 4661.4 4666.1 4688.7 5047.7 5059.3 5059.7 5074.5 5104.6 4847.6 4959.2 4968.1 5066.1 5076.5 4606.4 4684.9 4691.3 4727.8 4750.1 5232.7 5236.5 5237.8 5287.0 5289.3 4751.2 4864.3 5024.3 5027.8 5031.0 4864.8 5049.3 5111.5 5115.8 5157.2 4987.8 4988.3 5005.1 5023.1 5029.3 4800.8 4907.0 4973.4 4980.8 4990.5 4164.6 4195.8 4239.1 4245.1 4280.1 3700.3 3718.3 3744.1 3744.7 3767.7 4149.9 4247.6 4391.3 4402.3 4428.5 4937.6 5066.5 5173.5 5183.0 5224.6 4429.8 4461.8 4462.0 4467.8 4490.0 4307.3 4415.2 4609.2 4610.9 4637.2 4717.4 4771.2 4812.9 4823.2 4843.5 4916.3 4918.6 4923.5 4959.8 4966.1 4600.9 4675.5 4676.3 4696.9 4722.9 4867.9 4880.5 4893.9 4965.8 4973.2 5052.9 5071.6 5077.6 5080.3 5104.9 4873.0 4887.1 4890.5 4906.1 4922.1 4632.3 4746.6 4749.1 4753.3 4825.9 4848.4 4913.0 4925.4 4925.6 4950.4 5014.8 5046.3 5054.5 5055.2 5095.4 4496.4 4624.8 4629.9 4769.5 4940.0 07:53:08 INFO - 2015-11-18 07:53:08,295 DEBUG : BROWSER_OUTPUT: 07:53:08 INFO - 2015-11-18 07:53:08,295 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:37063.85 Median:33241.50 stddev:54871.42 (165.1%) stddev-sans-first:54956.90 07:53:08 INFO - 2015-11-18 07:53:08,296 DEBUG : BROWSER_OUTPUT: Values: 563.9 574.9 577.2 579.7 582.2 26538.3 27164.6 27189.2 27211.2 33532.5 39796.6 40242.6 40285.8 40320.8 40361.2 7986.2 8153.6 8158.5 8160.1 8161.7 6930.2 7071.9 7072.0 7073.0 7956.0 7063.0 10287.4 10645.8 10650.0 10654.4 10109.1 10227.6 10230.7 10234.4 10244.1 7132.0 7332.8 9898.3 10032.4 10052.6 40769.6 41528.8 41765.4 41787.8 41794.8 2869.6 2943.7 2965.0 3590.0 3675.3 26007.2 27354.6 27690.2 28089.0 28367.7 3034.4 3042.5 3098.1 3113.1 3176.8 188856.0 188976.0 189055.0 190095.0 190274.0 51266.5 51376.0 51443.0 51587.7 51630.5 54130.2 54275.5 54333.2 54367.5 54384.0 11766.8 12017.0 12089.5 12103.5 12129.5 9242.3 9309.4 9314.6 9314.8 9385.7 17905.7 18236.3 18369.5 18398.4 18438.6 6889.9 7150.0 7258.9 7259.9 7303.3 792.2 845.5 866.5 910.1 988.8 25804.5 26323.5 26942.7 26963.5 28070.3 816.9 857.2 862.8 906.6 919.0 12759.3 12883.2 13026.3 13095.0 13135.9 256540.0 260367.0 260550.0 260864.0 261045.0 39466.0 40602.4 42988.8 43901.3 43919.8 1119.6 1134.6 1139.2 1139.4 1146.9 23092.0 24458.3 25811.2 26059.0 26469.7 36735.3 37080.8 37082.4 37161.3 37200.6 172953.0 174571.0 174600.1 174694.0 174778.1 27718.3 28289.9 28299.7 28317.3 28357.9 38389.8 39238.0 39242.8 39419.0 39719.0 32194.4 33188.8 33294.2 33917.0 34027.7 33117.3 33615.8 33706.3 33753.7 33927.5 33456.5 33649.8 33709.7 33937.0 34006.8 29978.0 30062.5 30389.4 30555.5 30592.0 23570.8 23721.5 23914.0 24000.9 24138.6 07:53:08 INFO - 2015-11-18 07:53:08,296 DEBUG : BROWSER_OUTPUT: 07:53:08 INFO - 2015-11-18 07:53:08,296 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24088.39 Median:2537.03 stddev:79489.50 (3133.2%) stddev-sans-first:79692.42 07:53:08 INFO - 2015-11-18 07:53:08,297 DEBUG : BROWSER_OUTPUT: Values: 304.1 304.3 310.6 311.9 312.5 12393.3 12824.0 15921.4 16265.5 16451.6 12539.4 15024.9 15768.2 16297.0 16308.5 4873.0 4888.9 4974.8 4975.4 4980.7 3517.3 3617.7 4842.7 4886.7 5418.0 5481.6 5507.7 5531.8 5533.4 5540.4 4399.9 4515.9 4521.0 5493.5 5499.4 3892.2 3898.5 3903.3 3903.6 3905.2 11648.5 11720.6 11991.0 11992.7 12000.8 1686.5 1703.6 1733.4 1814.4 1820.7 8454.7 8581.1 8646.6 8652.6 8847.8 1530.7 1531.1 1539.2 1588.7 1605.0 51713.0 52635.7 52651.5 52669.2 53316.2 6068.3 6088.5 6089.3 6107.4 6179.6 7057.7 7119.8 7123.3 7131.9 7146.0 4488.3 4522.8 4574.2 4597.5 4604.3 4560.3 4561.7 4576.2 4586.6 4589.8 2763.0 2780.7 2783.2 2796.1 2799.6 1003.9 1010.7 1041.9 1062.8 2758.4 378.3 386.0 394.6 409.3 436.3 10252.4 10574.8 10579.3 10616.5 10633.5 369.0 393.6 400.1 429.5 438.8 5148.1 5389.6 5467.0 5477.3 5689.7 475298.0 479061.0 483711.0 492648.0 495966.0 63805.7 66353.0 66675.7 66966.3 67210.0 460.3 469.7 470.0 470.5 471.7 9392.1 9431.9 9443.7 9491.7 9570.0 30536.2 31405.8 32617.2 32869.2 33555.5 38687.4 39226.6 39558.2 41077.8 41290.0 5860.3 6009.4 6032.2 6036.5 6040.4 10567.1 10649.3 10753.4 10822.1 10853.0 9561.3 9584.8 9655.1 9677.2 9759.0 9105.7 9149.3 9191.4 9274.0 9509.2 8323.4 8554.8 9310.5 9412.0 9563.6 5826.2 5916.4 5927.4 5934.2 5985.0 9061.1 9267.1 9267.4 9462.6 9465.4 07:53:08 INFO - 2015-11-18 07:53:08,297 DEBUG : BROWSER_OUTPUT: 07:53:08 INFO - 2015-11-18 07:53:08,297 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4694.19 Median:5895.41 stddev:2414.01 (40.9%) stddev-sans-first:2408.06 07:53:08 INFO - 2015-11-18 07:53:08,297 DEBUG : BROWSER_OUTPUT: Values: 1397.3 1590.6 1617.2 1647.5 1658.1 5663.2 6274.2 6401.4 6436.2 6447.3 6571.0 6621.0 6651.2 6652.1 6654.2 1587.8 1647.3 1944.8 1963.6 1965.6 1926.7 1969.7 1980.0 1981.2 1981.4 1894.1 1917.5 1921.9 1952.7 1955.7 1913.2 1924.4 1927.7 1931.1 1931.3 1965.5 2021.0 2022.0 2022.5 2023.0 6707.4 6790.9 6793.2 6794.4 6797.9 3827.8 3900.5 3902.5 3914.8 3926.8 2590.7 2656.1 2703.0 2728.5 2762.6 726.7 737.7 755.6 837.0 845.9 8900.4 8933.2 8934.8 8941.9 8966.6 3668.4 3686.4 3732.5 3747.3 3751.6 7916.6 7919.5 7925.6 7931.2 7931.7 3984.3 3988.1 3996.3 4002.3 4013.0 3608.4 3609.4 3609.5 3611.5 3613.6 2853.6 2902.9 3224.0 3226.1 3269.8 999.7 1022.4 1026.9 1032.9 1051.4 927.0 1076.3 1105.6 1136.1 1136.2 6496.1 6536.6 6554.2 6555.8 6567.4 993.3 1011.3 1013.1 1017.4 1028.6 5014.4 5099.0 5111.3 5113.6 5116.8 7897.2 7995.9 8083.6 8087.9 8162.6 8025.8 8093.9 8101.5 8155.6 8179.2 6387.6 6439.6 6452.2 6486.6 6496.6 5898.5 5964.5 6000.5 6013.1 6046.2 7204.1 7242.1 7280.3 7302.2 7328.7 7302.6 7365.0 7365.4 7475.8 7499.7 5997.8 6094.5 6103.2 6119.0 6135.2 5356.3 5388.9 6578.2 6620.0 6628.2 5994.1 6007.8 6043.4 6087.4 6125.1 5947.2 5947.3 6001.3 6016.3 6019.6 5892.3 5926.6 5934.2 5936.6 5939.1 5403.5 5475.4 5664.2 5665.9 5668.6 5668.0 5693.8 5712.6 5713.7 5715.1 07:53:08 INFO - 2015-11-18 07:53:08,297 DEBUG : BROWSER_OUTPUT: 07:53:08 INFO - 2015-11-18 07:53:08,297 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4679.03 Median:5400.36 stddev:1416.72 (26.2%) stddev-sans-first:1381.54 07:53:08 INFO - 2015-11-18 07:53:08,298 DEBUG : BROWSER_OUTPUT: Values: 271.6 275.4 275.8 277.6 280.5 5291.2 5367.8 5392.1 5398.9 5422.7 5215.0 5388.1 5401.8 5403.7 5422.2 4108.9 4112.5 4116.7 4117.6 4128.8 3897.8 3988.2 4023.4 4109.6 4112.6 4082.6 4093.4 4096.4 4100.0 4101.5 4063.1 4064.9 4073.4 4080.5 4085.6 3537.7 3537.8 3538.0 3544.2 3544.8 5107.7 5194.8 5238.6 5241.6 5247.2 4710.1 4716.5 4716.7 4719.2 4725.0 5666.9 5670.0 5670.1 5672.1 5673.2 3865.5 3876.1 3876.6 3877.2 3877.5 5494.9 5608.1 5964.1 5973.1 5979.2 3842.8 3952.0 3955.8 3956.6 3957.5 4014.6 4024.5 4027.4 4029.9 4033.0 4646.2 4657.0 4657.6 4660.3 4667.2 5668.1 5676.3 5680.9 5681.4 5681.5 1328.4 1376.8 1377.0 1378.0 1378.8 890.2 903.0 908.0 909.2 919.2 4958.1 4971.2 4978.0 4982.0 4986.1 5858.2 5864.5 5871.9 5875.6 5877.3 4835.1 4869.2 4977.4 4982.8 4985.7 3141.9 3159.1 3163.9 3167.1 3170.1 5611.3 5631.9 5644.7 5646.6 5651.2 5957.9 6091.7 6113.5 6117.8 6132.5 5643.3 5645.3 5661.2 5664.3 5668.4 5940.4 5948.0 5951.1 5963.1 5973.3 5702.1 5829.0 5833.4 5836.3 5839.4 5634.9 5638.9 5647.7 5648.7 5656.9 3874.2 3907.3 3908.2 3914.1 3915.1 5938.4 5943.0 5946.3 5946.3 5946.8 5571.0 5675.2 5690.7 5694.6 5697.9 5649.7 5651.2 5652.4 5653.2 5662.2 5563.4 5567.9 5569.6 5576.5 5588.9 5624.0 5730.5 5739.6 5740.3 5745.7 5522.3 5553.3 5568.3 5573.9 5577.2 07:53:08 INFO - 2015-11-18 07:53:08,298 DEBUG : BROWSER_OUTPUT: 07:53:08 INFO - 2015-11-18 07:53:08,299 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12230.92 Median:42118.37 stddev:14186.88 (33.7%) stddev-sans-first:14199.88 07:53:08 INFO - 2015-11-18 07:53:08,299 DEBUG : BROWSER_OUTPUT: Values: 620.9 722.0 745.8 753.5 766.5 11577.5 11727.2 11736.9 11748.5 11778.6 11815.0 12049.3 12135.7 12141.8 12145.1 609.3 616.6 779.1 780.4 797.5 791.1 800.4 800.8 803.2 803.7 632.9 762.7 816.5 839.8 840.1 640.6 791.0 801.6 802.5 803.5 601.6 603.5 603.6 603.9 603.9 12021.2 12285.8 12299.1 12328.2 12332.4 11054.6 11392.7 11490.5 11923.4 12510.1 9947.3 9968.3 10006.7 10014.0 10040.2 3172.4 3224.7 3228.3 3285.1 3291.4 40976.2 41028.6 41028.6 41137.2 41284.8 9635.2 9641.1 9817.3 9818.1 9844.3 10795.5 10914.6 10925.9 10929.7 10930.4 5269.1 5329.5 5530.6 5590.4 5595.8 3336.1 3393.4 3408.3 3409.9 3410.1 2498.4 2601.0 2603.8 2609.0 2611.4 397.7 400.7 402.1 402.9 404.6 408.9 451.7 464.0 479.1 516.0 7478.1 7549.4 7562.7 7599.4 7922.2 386.6 429.9 569.8 609.5 609.5 3785.5 3789.7 3885.1 3914.8 3954.6 51808.0 52511.2 52602.7 52604.0 52783.5 42536.8 42764.6 43505.1 43527.8 45328.8 38851.4 39423.4 41324.4 41693.0 41747.8 8166.8 8243.1 8265.3 8326.5 8401.3 32306.2 32615.0 32951.2 33025.3 33240.0 40353.2 41442.0 41848.0 41948.2 42288.6 6674.3 6763.3 6909.8 7304.9 7413.1 11647.2 11840.7 11957.6 11989.1 12413.9 9999.5 10491.4 10599.2 10731.4 10880.8 10614.1 10642.3 10707.3 10746.3 10904.8 7857.0 9978.7 11093.3 11373.1 11459.7 8996.6 9186.9 9335.2 9538.5 9641.3 9327.5 9658.6 9847.7 9858.4 9860.3 07:53:08 INFO - 2015-11-18 07:53:08,299 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:53:08 INFO - 2015-11-18 07:53:08,299 DEBUG : BROWSER_OUTPUT: 07:53:09 INFO - 2015-11-18 07:53:09,081 INFO : Browser exited with error code: 0 07:53:09 INFO - 2015-11-18 07:53:09,102 INFO : Completed test dromaeo_css (00:18:37) 07:53:09 INFO - 2015-11-18 07:53:09,102 INFO : Starting test kraken 07:53:09 INFO - 2015-11-18 07:53:09,102 DEBUG : operating with platform_type : linux_ 07:53:09 INFO - 2015-11-18 07:53:09,103 INFO : Initialising browser for kraken test... 07:53:09 INFO - 2015-11-18 07:53:09,108 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSOE77W/profile http://localhost:38171/getInfo.html 07:53:13 INFO - 2015-11-18 07:53:13,419 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:53:13 INFO - 2015-11-18 07:53:13,420 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:53:13 INFO - 2015-11-18 07:53:13,420 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:53:13 INFO - 2015-11-18 07:53:13,420 DEBUG : BROWSER_OUTPUT: __metrics 07:53:13 INFO - 2015-11-18 07:53:13,564 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:53:14 INFO - 2015-11-18 07:53:14,879 INFO : Browser initialized. 07:53:14 INFO - 2015-11-18 07:53:14,879 INFO : Running cycle 1/1 for kraken test... 07:53:14 INFO - 2015-11-18 07:53:14,880 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSOE77W/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:53:26 INFO - 2015-11-18 07:53:26,837 DEBUG : BROWSER_OUTPUT: RSS: Main: 139145216 07:53:26 INFO - 2015-11-18 07:53:26,837 DEBUG : BROWSER_OUTPUT: 07:53:29 INFO - 2015-11-18 07:53:29,453 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38171/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38171/tests/kraken/driver.html?testName=audio-beat-detection) 07:53:30 INFO - 2015-11-18 07:53:30,040 DEBUG : BROWSER_OUTPUT: RSS: Main: 178372608 07:53:30 INFO - 2015-11-18 07:53:30,040 DEBUG : BROWSER_OUTPUT: 07:53:32 INFO - 2015-11-18 07:53:32,765 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38171/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38171/tests/kraken/driver.html?testName=audio-dft) 07:53:33 INFO - 2015-11-18 07:53:33,346 DEBUG : BROWSER_OUTPUT: RSS: Main: 167944192 07:53:33 INFO - 2015-11-18 07:53:33,346 DEBUG : BROWSER_OUTPUT: 07:53:36 INFO - 2015-11-18 07:53:36,350 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38171/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38171/tests/kraken/driver.html?testName=audio-fft) 07:53:36 INFO - 2015-11-18 07:53:36,917 DEBUG : BROWSER_OUTPUT: RSS: Main: 154800128 07:53:36 INFO - 2015-11-18 07:53:36,917 DEBUG : BROWSER_OUTPUT: 07:53:38 INFO - 2015-11-18 07:53:38,954 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38171/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38171/tests/kraken/driver.html?testName=audio-oscillator) 07:53:39 INFO - 2015-11-18 07:53:39,523 DEBUG : BROWSER_OUTPUT: RSS: Main: 155299840 07:53:39 INFO - 2015-11-18 07:53:39,523 DEBUG : BROWSER_OUTPUT: 07:53:41 INFO - 2015-11-18 07:53:41,756 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38171/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38171/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:53:42 INFO - 2015-11-18 07:53:42,321 DEBUG : BROWSER_OUTPUT: RSS: Main: 155987968 07:53:42 INFO - 2015-11-18 07:53:42,322 DEBUG : BROWSER_OUTPUT: 07:53:45 INFO - 2015-11-18 07:53:45,320 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38171/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38171/tests/kraken/driver.html?testName=imaging-darkroom) 07:53:45 INFO - 2015-11-18 07:53:45,893 DEBUG : BROWSER_OUTPUT: RSS: Main: 156688384 07:53:45 INFO - 2015-11-18 07:53:45,893 DEBUG : BROWSER_OUTPUT: 07:53:49 INFO - 2015-11-18 07:53:49,342 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38171/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38171/tests/kraken/driver.html?testName=imaging-desaturate) 07:53:49 INFO - 2015-11-18 07:53:49,923 DEBUG : BROWSER_OUTPUT: RSS: Main: 156499968 07:53:49 INFO - 2015-11-18 07:53:49,923 DEBUG : BROWSER_OUTPUT: 07:53:52 INFO - 2015-11-18 07:53:52,725 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38171/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38171/tests/kraken/driver.html?testName=json-parse-financial) 07:53:53 INFO - 2015-11-18 07:53:53,306 DEBUG : BROWSER_OUTPUT: RSS: Main: 156155904 07:53:53 INFO - 2015-11-18 07:53:53,306 DEBUG : BROWSER_OUTPUT: 07:53:55 INFO - 2015-11-18 07:53:55,080 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38171/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38171/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:53:55 INFO - 2015-11-18 07:53:55,641 DEBUG : BROWSER_OUTPUT: RSS: Main: 163352576 07:53:55 INFO - 2015-11-18 07:53:55,641 DEBUG : BROWSER_OUTPUT: 07:53:57 INFO - 2015-11-18 07:53:57,535 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38171/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38171/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:53:58 INFO - 2015-11-18 07:53:58,129 DEBUG : BROWSER_OUTPUT: RSS: Main: 164036608 07:53:58 INFO - 2015-11-18 07:53:58,129 DEBUG : BROWSER_OUTPUT: 07:54:00 INFO - 2015-11-18 07:54:00,281 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38171/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38171/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:54:00 INFO - 2015-11-18 07:54:00,862 DEBUG : BROWSER_OUTPUT: RSS: Main: 171855872 07:54:00 INFO - 2015-11-18 07:54:00,862 DEBUG : BROWSER_OUTPUT: 07:54:03 INFO - 2015-11-18 07:54:03,402 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38171/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38171/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:54:03 INFO - 2015-11-18 07:54:03,991 DEBUG : BROWSER_OUTPUT: RSS: Main: 176705536 07:54:03 INFO - 2015-11-18 07:54:03,991 DEBUG : BROWSER_OUTPUT: 07:54:06 INFO - 2015-11-18 07:54:06,646 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38171/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38171/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:54:07 INFO - 2015-11-18 07:54:07,227 DEBUG : BROWSER_OUTPUT: RSS: Main: 176889856 07:54:07 INFO - 2015-11-18 07:54:07,227 DEBUG : BROWSER_OUTPUT: 07:54:09 INFO - 2015-11-18 07:54:09,017 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38171/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38171/tests/kraken/driver.html?testName=ai-astar) 07:54:09 INFO - 2015-11-18 07:54:09,267 DEBUG : BROWSER_OUTPUT: RSS: Main: 235175936 07:54:09 INFO - 2015-11-18 07:54:09,267 DEBUG : BROWSER_OUTPUT: 07:54:09 INFO - 2015-11-18 07:54:09,268 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:54:09 INFO - 2015-11-18 07:54:09,269 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:54:09 INFO - 2015-11-18 07:54:09,269 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:54:09 INFO - 2015-11-18 07:54:09,269 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:54:09 INFO - 2015-11-18 07:54:09,269 DEBUG : BROWSER_OUTPUT: |0;ai-astar;114;109;113;112;114;120;112;112;112;112 07:54:09 INFO - 2015-11-18 07:54:09,269 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;167;133;154;164;129;151;154;131;173;130 07:54:09 INFO - 2015-11-18 07:54:09,269 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;163;161;161;162;160;165;161;162;163 07:54:09 INFO - 2015-11-18 07:54:09,269 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;73;84;89;72;72;72;110;89;72 07:54:09 INFO - 2015-11-18 07:54:09,270 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;93;136;91;91;90;126;91;92;126 07:54:09 INFO - 2015-11-18 07:54:09,270 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;111;109;110;109;110;111;110;109;109 07:54:09 INFO - 2015-11-18 07:54:09,270 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;147;148;148;148;148;148;149;147;147 07:54:09 INFO - 2015-11-18 07:54:09,270 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;96;95;95;96;95;96;96;96 07:54:09 INFO - 2015-11-18 07:54:09,270 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;73;72;72;73;71;71;72;81;70;72 07:54:09 INFO - 2015-11-18 07:54:09,270 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;70;70;69;70;69;69;69;69;70 07:54:09 INFO - 2015-11-18 07:54:09,270 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;90;84;86;83;86;84;83;85;84 07:54:09 INFO - 2015-11-18 07:54:09,271 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;120;124;132;122;134;132;130;121;122;130 07:54:09 INFO - 2015-11-18 07:54:09,271 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;142;144;155;156;152;141;152;151;152;142 07:54:09 INFO - 2015-11-18 07:54:09,271 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;70;68;70;71;69;70;69;69;69 07:54:09 INFO - 2015-11-18 07:54:09,271 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:54:09 INFO - 2015-11-18 07:54:09,271 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:54:09 INFO - 2015-11-18 07:54:09,271 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,985 07:54:09 INFO - 2015-11-18 07:54:09,271 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:54:09 INFO - 2015-11-18 07:54:09,272 DEBUG : BROWSER_OUTPUT: __startTimestamp1447862049267__endTimestamp 07:54:09 INFO - 2015-11-18 07:54:09,272 DEBUG : BROWSER_OUTPUT: 07:54:09 INFO - 2015-11-18 07:54:09,279 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:54:09 INFO - 2015-11-18 07:54:09,279 DEBUG : BROWSER_OUTPUT: Number of tests: 14 07:54:09 INFO - 2015-11-18 07:54:09,279 DEBUG : BROWSER_OUTPUT: 07:54:09 INFO - 2015-11-18 07:54:09,279 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:113.00 Median:112.50 stddev:2.83 (2.5%) stddev-sans-first:2.98 07:54:09 INFO - 2015-11-18 07:54:09,279 DEBUG : BROWSER_OUTPUT: Values: 114.0 109.0 113.0 112.0 114.0 120.0 112.0 112.0 112.0 112.0 07:54:09 INFO - 2015-11-18 07:54:09,280 DEBUG : BROWSER_OUTPUT: 07:54:09 INFO - 2015-11-18 07:54:09,280 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.60 Median:154.00 stddev:16.73 (10.9%) stddev-sans-first:16.36 07:54:09 INFO - 2015-11-18 07:54:09,280 DEBUG : BROWSER_OUTPUT: Values: 167.0 133.0 154.0 164.0 129.0 151.0 154.0 131.0 173.0 130.0 07:54:09 INFO - 2015-11-18 07:54:09,280 DEBUG : BROWSER_OUTPUT: 07:54:09 INFO - 2015-11-18 07:54:09,280 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:1.41 (0.9%) stddev-sans-first:1.50 07:54:09 INFO - 2015-11-18 07:54:09,280 DEBUG : BROWSER_OUTPUT: Values: 162.0 163.0 161.0 161.0 162.0 160.0 165.0 161.0 162.0 163.0 07:54:09 INFO - 2015-11-18 07:54:09,280 DEBUG : BROWSER_OUTPUT: 07:54:09 INFO - 2015-11-18 07:54:09,280 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.50 Median:72.50 stddev:12.67 (17.5%) stddev-sans-first:13.06 07:54:09 INFO - 2015-11-18 07:54:09,280 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 84.0 89.0 72.0 72.0 72.0 110.0 89.0 72.0 07:54:09 INFO - 2015-11-18 07:54:09,280 DEBUG : BROWSER_OUTPUT: 07:54:09 INFO - 2015-11-18 07:54:09,280 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.80 Median:91.00 stddev:18.53 (20.4%) stddev-sans-first:19.24 07:54:09 INFO - 2015-11-18 07:54:09,280 DEBUG : BROWSER_OUTPUT: Values: 92.0 93.0 136.0 91.0 91.0 90.0 126.0 91.0 92.0 126.0 07:54:09 INFO - 2015-11-18 07:54:09,280 DEBUG : BROWSER_OUTPUT: 07:54:09 INFO - 2015-11-18 07:54:09,280 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.79 (0.7%) stddev-sans-first:0.83 07:54:09 INFO - 2015-11-18 07:54:09,280 DEBUG : BROWSER_OUTPUT: Values: 110.0 111.0 109.0 110.0 109.0 110.0 111.0 110.0 109.0 109.0 07:54:09 INFO - 2015-11-18 07:54:09,280 DEBUG : BROWSER_OUTPUT: 07:54:09 INFO - 2015-11-18 07:54:09,281 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 07:54:09 INFO - 2015-11-18 07:54:09,281 DEBUG : BROWSER_OUTPUT: Values: 148.0 147.0 148.0 148.0 148.0 148.0 148.0 149.0 147.0 147.0 07:54:09 INFO - 2015-11-18 07:54:09,281 DEBUG : BROWSER_OUTPUT: 07:54:09 INFO - 2015-11-18 07:54:09,281 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 07:54:09 INFO - 2015-11-18 07:54:09,281 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 96.0 95.0 95.0 96.0 95.0 96.0 96.0 96.0 07:54:09 INFO - 2015-11-18 07:54:09,281 DEBUG : BROWSER_OUTPUT: 07:54:09 INFO - 2015-11-18 07:54:09,281 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.70 Median:72.00 stddev:3.06 (4.2%) stddev-sans-first:3.24 07:54:09 INFO - 2015-11-18 07:54:09,281 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 72.0 73.0 71.0 71.0 72.0 81.0 70.0 72.0 07:54:09 INFO - 2015-11-18 07:54:09,281 DEBUG : BROWSER_OUTPUT: 07:54:09 INFO - 2015-11-18 07:54:09,281 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.40 Median:69.50 stddev:0.52 (0.7%) stddev-sans-first:0.53 07:54:09 INFO - 2015-11-18 07:54:09,281 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 70.0 69.0 70.0 69.0 69.0 69.0 69.0 70.0 07:54:09 INFO - 2015-11-18 07:54:09,281 DEBUG : BROWSER_OUTPUT: 07:54:09 INFO - 2015-11-18 07:54:09,281 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:84.50 stddev:2.15 (2.5%) stddev-sans-first:2.18 07:54:09 INFO - 2015-11-18 07:54:09,281 DEBUG : BROWSER_OUTPUT: Values: 83.0 90.0 84.0 86.0 83.0 86.0 84.0 83.0 85.0 84.0 07:54:09 INFO - 2015-11-18 07:54:09,281 DEBUG : BROWSER_OUTPUT: 07:54:09 INFO - 2015-11-18 07:54:09,281 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:126.70 Median:130.00 stddev:5.38 (4.1%) stddev-sans-first:5.13 07:54:09 INFO - 2015-11-18 07:54:09,282 DEBUG : BROWSER_OUTPUT: Values: 120.0 124.0 132.0 122.0 134.0 132.0 130.0 121.0 122.0 130.0 07:54:09 INFO - 2015-11-18 07:54:09,282 DEBUG : BROWSER_OUTPUT: 07:54:09 INFO - 2015-11-18 07:54:09,282 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.70 Median:152.00 stddev:5.79 (3.8%) stddev-sans-first:5.61 07:54:09 INFO - 2015-11-18 07:54:09,282 DEBUG : BROWSER_OUTPUT: Values: 142.0 144.0 155.0 156.0 152.0 141.0 152.0 151.0 152.0 142.0 07:54:09 INFO - 2015-11-18 07:54:09,282 DEBUG : BROWSER_OUTPUT: 07:54:09 INFO - 2015-11-18 07:54:09,282 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:70.00 stddev:0.97 (1.4%) stddev-sans-first:0.88 07:54:09 INFO - 2015-11-18 07:54:09,282 DEBUG : BROWSER_OUTPUT: Values: 71.0 70.0 68.0 70.0 71.0 69.0 70.0 69.0 69.0 69.0 07:54:09 INFO - 2015-11-18 07:54:09,282 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:54:09 INFO - 2015-11-18 07:54:09,282 DEBUG : BROWSER_OUTPUT: 07:54:10 INFO - 2015-11-18 07:54:10,157 INFO : Browser exited with error code: 0 07:54:10 INFO - 2015-11-18 07:54:10,205 INFO : Completed test kraken (00:01:01) 07:54:10 INFO - 2015-11-18 07:54:10,205 INFO : Starting test v8_7 07:54:10 INFO - 2015-11-18 07:54:10,205 DEBUG : operating with platform_type : linux_ 07:54:10 INFO - 2015-11-18 07:54:10,206 INFO : Initialising browser for v8_7 test... 07:54:10 INFO - 2015-11-18 07:54:10,212 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppCiOJv/profile http://localhost:38171/getInfo.html 07:54:14 INFO - 2015-11-18 07:54:14,419 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:54:14 INFO - 2015-11-18 07:54:14,419 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:54:14 INFO - 2015-11-18 07:54:14,420 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:54:14 INFO - 2015-11-18 07:54:14,420 DEBUG : BROWSER_OUTPUT: __metrics 07:54:14 INFO - 2015-11-18 07:54:14,561 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:54:15 INFO - 2015-11-18 07:54:15,881 INFO : Browser initialized. 07:54:15 INFO - 2015-11-18 07:54:15,882 INFO : Running cycle 1/1 for v8_7 test... 07:54:15 INFO - 2015-11-18 07:54:15,882 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppCiOJv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:54:27 INFO - 2015-11-18 07:54:27,876 DEBUG : BROWSER_OUTPUT: RSS: Main: 140255232 07:54:27 INFO - 2015-11-18 07:54:27,876 DEBUG : BROWSER_OUTPUT: 07:54:49 INFO - 2015-11-18 07:54:49,330 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38171/tests/v8_7/run.html (next: http://localhost:38171/tests/v8_7/run.html) 07:54:49 INFO - 2015-11-18 07:54:49,588 DEBUG : BROWSER_OUTPUT: RSS: Main: 438460416 07:54:49 INFO - 2015-11-18 07:54:49,588 DEBUG : BROWSER_OUTPUT: 07:54:49 INFO - 2015-11-18 07:54:49,588 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:54:49 INFO - 2015-11-18 07:54:49,588 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:54:49 INFO - 2015-11-18 07:54:49,588 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:54:49 INFO - 2015-11-18 07:54:49,589 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:54:49 INFO - 2015-11-18 07:54:49,589 DEBUG : BROWSER_OUTPUT: |0;Richards;164.257555847569 07:54:49 INFO - 2015-11-18 07:54:49,589 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.6665428889714 07:54:49 INFO - 2015-11-18 07:54:49,589 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.4857462269424 07:54:49 INFO - 2015-11-18 07:54:49,589 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5040.201005025126 07:54:49 INFO - 2015-11-18 07:54:49,589 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2014.0845070422536 07:54:49 INFO - 2015-11-18 07:54:49,589 DEBUG : BROWSER_OUTPUT: |5;Earley;783.0853563038371 07:54:49 INFO - 2015-11-18 07:54:49,589 DEBUG : BROWSER_OUTPUT: |6;Boyer;12120.481927710844 07:54:49 INFO - 2015-11-18 07:54:49,590 DEBUG : BROWSER_OUTPUT: |7;RegExp;26447.36842105263 07:54:49 INFO - 2015-11-18 07:54:49,590 DEBUG : BROWSER_OUTPUT: |8;Splay;610.738255033557 07:54:49 INFO - 2015-11-18 07:54:49,590 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 07:54:49 INFO - 2015-11-18 07:54:49,590 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:54:49 INFO - 2015-11-18 07:54:49,590 DEBUG : BROWSER_OUTPUT: __startTimestamp1447862089582__endTimestamp 07:54:49 INFO - 2015-11-18 07:54:49,590 DEBUG : BROWSER_OUTPUT: 07:54:49 INFO - 2015-11-18 07:54:49,590 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:54:49 INFO - 2015-11-18 07:54:49,590 DEBUG : BROWSER_OUTPUT: Number of tests: 10 07:54:49 INFO - 2015-11-18 07:54:49,590 DEBUG : BROWSER_OUTPUT: 07:54:49 INFO - 2015-11-18 07:54:49,590 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.26 Median:164.26 stddev:0.00 (0.0%) 07:54:49 INFO - 2015-11-18 07:54:49,590 DEBUG : BROWSER_OUTPUT: Values: 164.3 07:54:49 INFO - 2015-11-18 07:54:49,590 DEBUG : BROWSER_OUTPUT: 07:54:49 INFO - 2015-11-18 07:54:49,590 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.67 Median:185.67 stddev:0.00 (0.0%) 07:54:49 INFO - 2015-11-18 07:54:49,591 DEBUG : BROWSER_OUTPUT: Values: 185.7 07:54:49 INFO - 2015-11-18 07:54:49,591 DEBUG : BROWSER_OUTPUT: 07:54:49 INFO - 2015-11-18 07:54:49,591 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.49 Median:279.49 stddev:0.00 (0.0%) 07:54:49 INFO - 2015-11-18 07:54:49,591 DEBUG : BROWSER_OUTPUT: Values: 279.5 07:54:49 INFO - 2015-11-18 07:54:49,591 DEBUG : BROWSER_OUTPUT: 07:54:49 INFO - 2015-11-18 07:54:49,591 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5040.20 Median:5040.20 stddev:0.00 (0.0%) 07:54:49 INFO - 2015-11-18 07:54:49,591 DEBUG : BROWSER_OUTPUT: Values: 5040.2 07:54:49 INFO - 2015-11-18 07:54:49,591 DEBUG : BROWSER_OUTPUT: 07:54:49 INFO - 2015-11-18 07:54:49,591 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2014.08 Median:2014.08 stddev:0.00 (0.0%) 07:54:49 INFO - 2015-11-18 07:54:49,591 DEBUG : BROWSER_OUTPUT: Values: 2014.1 07:54:49 INFO - 2015-11-18 07:54:49,591 DEBUG : BROWSER_OUTPUT: 07:54:49 INFO - 2015-11-18 07:54:49,591 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:783.09 Median:783.09 stddev:0.00 (0.0%) 07:54:49 INFO - 2015-11-18 07:54:49,591 DEBUG : BROWSER_OUTPUT: Values: 783.1 07:54:49 INFO - 2015-11-18 07:54:49,591 DEBUG : BROWSER_OUTPUT: 07:54:49 INFO - 2015-11-18 07:54:49,591 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12120.48 Median:12120.48 stddev:0.00 (0.0%) 07:54:49 INFO - 2015-11-18 07:54:49,591 DEBUG : BROWSER_OUTPUT: Values: 12120.5 07:54:49 INFO - 2015-11-18 07:54:49,592 DEBUG : BROWSER_OUTPUT: 07:54:49 INFO - 2015-11-18 07:54:49,592 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26447.37 Median:26447.37 stddev:0.00 (0.0%) 07:54:49 INFO - 2015-11-18 07:54:49,592 DEBUG : BROWSER_OUTPUT: Values: 26447.4 07:54:49 INFO - 2015-11-18 07:54:49,592 DEBUG : BROWSER_OUTPUT: 07:54:49 INFO - 2015-11-18 07:54:49,592 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:610.74 Median:610.74 stddev:0.00 (0.0%) 07:54:49 INFO - 2015-11-18 07:54:49,592 DEBUG : BROWSER_OUTPUT: Values: 610.7 07:54:49 INFO - 2015-11-18 07:54:49,592 DEBUG : BROWSER_OUTPUT: 07:54:49 INFO - 2015-11-18 07:54:49,592 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 07:54:49 INFO - 2015-11-18 07:54:49,592 DEBUG : BROWSER_OUTPUT: Values: 4826.9 07:54:49 INFO - 2015-11-18 07:54:49,592 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:54:49 INFO - 2015-11-18 07:54:49,592 DEBUG : BROWSER_OUTPUT: 07:54:50 INFO - 2015-11-18 07:54:50,445 INFO : Browser exited with error code: 0 07:54:50 INFO - 2015-11-18 07:54:50,462 INFO : Completed test v8_7 (00:00:40) 07:54:50 INFO - 2015-11-18 07:54:50,599 INFO : Completed test suite (00:20:19) 07:54:50 INFO - 2015-11-18 07:54:50,600 DEBUG : Working with test: dromaeo_css 07:54:50 INFO - 2015-11-18 07:54:50,600 DEBUG : Generating results file: dromaeo_css 07:54:50 INFO - 2015-11-18 07:54:50,601 DEBUG : Working with test: kraken 07:54:50 INFO - 2015-11-18 07:54:50,601 DEBUG : Generating results file: kraken 07:54:50 INFO - 2015-11-18 07:54:50,601 INFO : javascript benchmark 07:54:50 INFO - 2015-11-18 07:54:50,601 DEBUG : Working with test: v8_7 07:54:50 INFO - 2015-11-18 07:54:50,602 DEBUG : Generating results file: v8_7 07:54:50 INFO - 2015-11-18 07:54:50,602 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:54:50 INFO - 2015-11-18 07:54:50,653 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 07:54:50 INFO - 2015-11-18 07:54:50,654 DEBUG : process_Request line: dromaeo_css 5905.76 graph.html#tests=[[72,132,35]] 07:54:50 INFO - 2015-11-18 07:54:50,654 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:54:50 INFO - 2015-11-18 07:54:50,690 DEBUG : process_Request line: kraken 1531.90 graph.html#tests=[[232,132,35]] 07:54:50 INFO - 2015-11-18 07:54:50,690 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:54:50 INFO - 2015-11-18 07:54:50,728 DEBUG : process_Request line: v8_7 19895.67 graph.html#tests=[[230,132,35]] 07:54:50 INFO - 2015-11-18 07:54:50,729 INFO : javascript benchmark 07:54:50 INFO - 2015-11-18 07:54:50,733 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2680.557707978183, 2739.1508632323967, 2776.4724702306567, 2782.012385603111, 2789.679186893508, 4562.178807814592, 4656.161890859644, 4693.483716791159, 4704.952950470499, 4739.597134243589, 4561.703489273195, 4670.743109128996, 4686.156491831469, 4768.809247630091, 4783.067301876135, 4344.066025804452, 4347.434833471644, 4360.825566977317, 4363.650907927358, 4389.648828093745, 4113.218488487193, 4471.575200355961, 4492.7528985905765, 4524.660650451213, 4525.728456292633, 4146.91706165878, 4235.597618226295, 4248.299030659938, 4253.447051883235, 4269.103488267437, 4312.805923733408, 4314.094040251551, 4323.329883868006, 4344.218040752663, 4367.672424568138, 4074.0833312504747, 4173.603507666767, 4275.978620106911, 4279.957200427987, 4313.137372525507, 4575.839845605421, 4655.51117132703, 4661.394018777572, 4666.136764698542, 4688.671792974493, 5047.671901326402, 5059.266406371093, 5059.671121377099, 5074.4671809460215, 5104.64267501275, 4847.612191024745, 4959.156943319645, 4968.056069346812, 5066.113430149709, 5076.466970968069, 4606.378138951266, 4684.929726054112, 4691.272852707768, 4727.834525791615, 4750.097481478508, 5232.659877107976, 5236.450172731885, 5237.8428647140645, 5287.048331300326, 5289.259503669489, 4751.216049351888, 4864.318995340655, 5024.296598476216, 5027.82402615914, 5030.974845125751, 4864.80540778372, 5049.343585333883, 5111.488851114933, 5115.820946266937, 5157.174852023658, 4987.80048798044, 4988.276699878497, 5005.099082165172, 5023.070731914608, 5029.2958985742025, 4800.783964721596, 4907.0, 4973.42805577356, 4980.77586508608, 4990.500949905053, 4164.604362585549, 4195.811188496525, 4239.0885959518855, 4245.066085461193, 4280.058387154821, 3700.296943580711, 3718.2749363874327, 3744.1388480649603, 3744.737868349244, 3767.698584113264, 4149.91700165995, 4247.5964783345535, 4391.3193455014525, 4402.25161722508, 4428.490723566767, 4937.580305674058, 5066.544011039025, 5173.456787037382, 5182.97408512955, 5224.608154388436, 4429.75636339998, 4461.843835465743, 4461.977690111528, 4467.83042394015, 4489.9551004490195, 4307.289297265978, 4415.227335216325, 4609.216433206363, 4610.9308360374625, 4637.234856248681, 4717.386739723883, 4771.212749896228, 4812.855614331575, 4823.1800593899825, 4843.450095969256, 4916.3362946001835, 4918.631102667386, 4923.520063567797, 4959.801607935642, 4966.130927087817, 4600.88497787558, 4675.485696573306, 4676.251799712166, 4696.8590942271785, 4722.905541889212, 4867.878303042452, 4880.511948805091, 4893.926591101065, 4965.751712414437, 4973.179425394769, 5052.873678158076, 5071.619628527949, 5077.644564880423, 5080.339555857715, 5104.872378190426, 4873.049755297683, 4887.144749668722, 4890.510948905081, 4906.067847109038, 4922.064807686528, 4632.25883858581, 4746.62027037843, 4749.097671442415, 4753.334533165429, 4825.927611085766, 4848.369711937426, 4912.95087049125, 4925.433575138905, 4925.605951523941, 4950.356453661001, 5014.799408023784, 5046.268291097844, 5054.494550544916, 5055.16589762685, 5095.363079615048, 4496.370508128799, 4624.838130665411, 4629.884252893705, 4769.523047695203, 4939.975300123477], "unit": "ms", "name": "dojo.html", "value": 4618.303634004554}, {"lowerIsBetter": false, "replicates": [563.8590352411894, 574.9108888122342, 577.1948132355365, 579.652208674795, 582.1733138942701, 26538.33654158647, 27164.592531112048, 27189.184324470272, 27211.183664490098, 33532.49701254483, 39796.60203397965, 40242.59757402425, 40285.7985710071, 40320.79839600805, 40361.19277614453, 7986.201379862011, 8153.551554664491, 8158.5104893706275, 8160.102388737234, 8161.6735330587, 6930.237673855897, 7071.929280707179, 7071.964640176818, 7073.009778630996, 7956.0, 7063.046488724033, 10287.434191119522, 10645.84031239532, 10650.0, 10654.360738355685, 10109.090181883628, 10227.590896364136, 10230.693079207636, 10234.385936843739, 10244.129249013842, 7132.0, 7332.78001659951, 9898.257630677655, 10032.398056116657, 10052.597896084148, 40769.592304076876, 41528.79235603803, 41765.37351939723, 41787.7910610448, 41794.79102604498, 2869.5982562441277, 2943.67619561848, 2964.9851750741323, 3589.958911915541, 3675.3384390809642, 26007.219783406526, 27354.589681154797, 27690.169294921183, 28089.0, 28367.716322836714, 3034.408290383376, 3042.5284080967485, 3098.148009297439, 3113.081640915935, 3176.777625566211, 188856.0, 188976.0, 189055.0, 190095.04952475286, 190274.0, 51266.48733512692, 51376.0, 51443.0, 51587.74206128946, 51630.48369516332, 54130.18804717853, 54275.45724542704, 54333.185002225, 54367.45632543703, 54384.0, 11766.823497647541, 12017.0, 12089.516419343303, 12103.515859365527, 12129.454174562166, 9242.260619150451, 9309.441433513875, 9314.627414903329, 9314.813703725888, 9385.671501497414, 17905.7314140288, 18236.27054917815, 18369.53043756496, 18398.356057537923, 18438.631227375376, 6889.896651550231, 7149.964250178716, 7258.927410725931, 7259.89110163348, 7303.342699156995, 792.2117493094293, 845.5307304445969, 866.4974314897345, 910.094456016268, 988.8170688422521, 25804.483910321687, 26323.47353052928, 26942.730572694414, 26963.460730785668, 28070.2982425441, 816.9142240064826, 857.1728282207699, 862.7713655881197, 906.6373450619805, 918.9678361257323, 12759.298238596966, 12883.227006379648, 13026.348682565835, 13095.0, 13135.934320328337, 256540.0, 260367.0, 260550.0, 260864.0, 261045.0, 39466.0, 40602.390964135564, 42988.78505607452, 43901.341479877825, 43919.78040109779, 1119.6025410979148, 1134.5518520184646, 1139.168407062832, 1139.3676509537286, 1146.8509093817918, 23092.0, 24458.26625201247, 25811.225663230132, 26059.0, 26469.735302646728, 36735.265294694495, 37080.81459592685, 37082.443763343035, 37161.25677486381, 37200.6279937208, 172953.0, 174571.0, 174600.12699936418, 174694.0, 174778.12610937373, 27718.307042324104, 28289.858550707115, 28299.71700283053, 28317.292067698472, 28357.858210708815, 38389.80805096068, 39238.0, 39242.80378598203, 39419.0, 39719.0, 32194.449439548906, 33188.83405582957, 33294.16764580905, 33917.0, 34027.65972340344, 33117.337653246315, 33615.83192084024, 33706.325873482885, 33753.66246337604, 33927.491087633214, 33456.49815252822, 33649.83175084109, 33709.662903370656, 33937.0, 34006.82996585001, 29978.0, 30062.54906176453, 30389.39221215519, 30555.54166687457, 30592.0, 23570.764292356856, 23721.52556948886, 23914.009415829067, 24000.87999559991, 24138.637920430858], "unit": "ms", "name": "ext.html", "value": 16361.632554657434}, {"lowerIsBetter": false, "replicates": [304.1210900497561, 304.3092180749698, 310.64586371536444, 311.8643390125294, 312.5062401405779, 12393.318367489806, 12824.0, 15921.36314547418, 16265.51203463895, 16451.588710282234, 12539.435725392357, 15024.924875375607, 15768.211589420513, 16297.0, 16308.51074467765, 4873.049755297719, 4888.902221955567, 4974.77613507393, 4975.3532040834825, 4980.6762560433635, 3517.26137511123, 3617.7105831533413, 4842.66101372904, 4886.657933944625, 5417.972910135444, 5481.616286859921, 5507.697076660782, 5531.806386776464, 5533.391326954052, 5540.36285827129, 4399.912001759979, 4515.932261016087, 4520.95479045212, 5493.450654934514, 5499.422560631137, 3892.2020985697864, 3898.5126859142606, 3903.316919539098, 3903.5706072332023, 3905.1799122184375, 11648.475818588184, 11720.648380548597, 11991.0, 11992.70018249542, 12000.759984800256, 1686.5005114387573, 1703.6081701208668, 1733.4366330942494, 1814.4012475882928, 1820.7359932809668, 8454.704085357045, 8581.056083830774, 8646.567671616456, 8652.567371631394, 8847.77880552985, 1530.670905755268, 1531.058399084555, 1539.168848821635, 1588.6663800601773, 1605.0209372282898, 51713.0, 52635.73682131603, 52651.47348526542, 52669.2099618506, 53316.20025699618, 6068.302145253264, 6088.452039316483, 6089.330173680892, 6107.358727333655, 6179.567430279837, 7057.682404291819, 7119.750808721774, 7123.2520585338825, 7131.8573628528175, 7145.999560061596, 4488.326750987313, 4522.841700540465, 4574.222382195035, 4597.517260687647, 4604.309353596987, 4560.270356742905, 4561.657875659339, 4576.199165146086, 4586.610138138296, 4589.816407343736, 2762.986185069102, 2780.652418447694, 2783.248522898806, 2796.1052463211986, 2799.552071668564, 1003.859459675646, 1010.7271036820017, 1041.8645576075062, 1062.7768168684663, 2758.3655759175504, 378.25295042291253, 386.04261431649667, 394.5994815262511, 409.25107054090944, 436.3236982676838, 10252.436116013541, 10574.841377379345, 10579.31234469757, 10616.469176541143, 10633.5214915329, 368.9538807649044, 393.5670762161657, 400.0618549501473, 429.49105310207506, 438.75210506063974, 5148.099082660519, 5389.622726409192, 5467.0, 5477.315335583052, 5689.686134445417, 475298.0, 479061.0, 483711.0, 492648.0, 495966.0, 63805.68097159485, 66353.0, 66675.66662166755, 66966.330336696, 67210.0, 460.298045480638, 469.7486844538224, 469.96945198561986, 470.52712024415246, 471.6698311182118, 9392.107749763762, 9431.858522122311, 9443.716688499357, 9491.66779162726, 9569.995150509096, 30536.236594085327, 31405.842970785, 32617.206053667276, 32869.17827054247, 33555.496667549516, 38687.41968870525, 39226.6077339223, 39558.2088358237, 41077.79461102675, 41290.0, 5860.267466566679, 6009.399060093956, 6032.245969253843, 6036.517078633611, 6040.36576159497, 10567.101796347397, 10649.307794993301, 10753.354798711789, 10822.134229261483, 10853.0, 9561.282903782383, 9584.76038099053, 9655.131038206595, 9677.177439917687, 9758.951205243928, 9105.681301154427, 9149.31380146505, 9191.35660503785, 9274.0, 9509.239260859253, 8323.375746819134, 8554.786130346542, 9310.487923164292, 9412.0, 9563.569639366384, 5826.184334193301, 5916.437938395846, 5927.407259274038, 5934.169216309634, 5985.042393217064, 9061.093890610886, 9267.073292670679, 9267.397619154734, 9462.574184161867, 9465.384749991228], "unit": "ms", "name": "jquery.html", "value": 6231.730408983312}, {"lowerIsBetter": false, "replicates": [1397.2734178227329, 1590.5864475236438, 1617.2398972482936, 1647.4645740134456, 1658.1294820219384, 5663.207150998864, 6274.215723034621, 6401.423871851533, 6436.195475565542, 6447.290798012221, 6571.047198156264, 6621.0, 6651.235107962586, 6652.101966234569, 6654.168228971379, 1587.8253392126858, 1647.3081305851572, 1944.795796441371, 1963.6072785442898, 1965.636357273909, 1926.749522562065, 1969.7439332886704, 1979.980200197994, 1981.187713037655, 1981.38577041117, 1894.1097684088525, 1917.5302050997525, 1921.8750781199246, 1952.6582848001615, 1955.6968669856124, 1913.2155816115396, 1924.422673198035, 1927.7493925789558, 1931.1020375525377, 1931.3433432632833, 1965.5282732144183, 2020.979790202094, 2021.9898900505402, 2022.4741567192636, 2023.0, 6707.3628005339415, 6790.898136527907, 6793.184817821843, 6794.388505034571, 6797.864042719118, 3827.7703337799544, 3900.5319361676497, 3902.5316961964463, 3914.7651140931634, 3926.8429262829454, 2590.6502622146145, 2656.1102030819507, 2702.9864850675817, 2728.45430913818, 2762.6270453488723, 726.742006587659, 737.7381029734474, 755.5806527377304, 837.0374069819695, 845.9154084591553, 8900.37697361185, 8933.19601235892, 8934.776630584221, 8941.910580894173, 8966.551672416419, 3668.3947148720695, 3686.3733165361955, 3732.496113024761, 3747.2880152770886, 3751.643593858579, 7916.6041697916025, 7919.485233459806, 7925.603719813987, 7931.167227441036, 7931.682732690743, 3984.322665146932, 3988.082740969593, 3996.260691771973, 4002.3196056670436, 4012.9799351003057, 3608.350496910529, 3609.3503169429755, 3609.5307610011055, 3611.5485564304463, 3613.638636136365, 2853.5576985566854, 2902.9274268143467, 3224.0489055728617, 3226.0966929259844, 3269.7711160218555, 999.7400675824338, 1022.3763504262394, 1026.9178465722725, 1032.948352582368, 1051.395447617623, 926.9756918604979, 1076.2950267574595, 1105.6406667832987, 1136.085451211766, 1136.193302755053, 6496.123023391781, 6536.600967496875, 6554.180727409074, 6555.8361040973405, 6567.376099270562, 993.2550587059706, 1011.261778901406, 1013.0780989299849, 1017.3743147963949, 1028.6142696488816, 5014.423341315723, 5098.974505127525, 5111.258867464197, 5113.565346945476, 5116.846494605168, 7897.1707970662255, 7995.880061799077, 8083.585372559778, 8087.878681819778, 8162.591870406574, 8025.799355016171, 8093.919060809434, 8101.473404228706, 8155.632996515171, 8179.222973817477, 6387.648679322682, 6439.613623182624, 6452.161219041494, 6486.643234622046, 6496.642684652389, 5898.528117750484, 5964.493018093511, 6000.549958753199, 6013.128096426081, 6046.2139921809885, 7204.135503739585, 7242.13094428672, 7280.271972802678, 7302.196758356683, 7328.670209840677, 7302.56184628924, 7365.0, 7365.447591430557, 7475.775726728207, 7499.737509187153, 5997.820065398045, 6094.451499365078, 6103.176071230505, 6118.990366589463, 6135.233095863017, 5356.250124982584, 5388.946110538845, 6578.210614726264, 6619.966900165661, 6628.204615446178, 5994.07091900756, 6007.849803754941, 6043.425874541911, 6087.391260873877, 6125.081237814364, 5947.226860508106, 5947.345791962967, 6001.279846418458, 6016.338202797601, 6019.638821670714, 5892.292924849045, 5926.614770040106, 5934.1988831508925, 5936.643801371932, 5939.10913362999, 5403.459654034722, 5475.425080366664, 5664.150377443417, 5665.886682266414, 5668.63153895012, 5668.0, 5693.829185124453, 5712.600117991867, 5713.714314284186, 5715.142728590745], "unit": "ms", "name": "mootools.html", "value": 3872.4354361532014}, {"lowerIsBetter": false, "replicates": [271.6156638356725, 275.42986018940786, 275.77248769764947, 277.56699548704023, 280.4643131618609, 5291.1798671205925, 5367.812126575571, 5392.137258038714, 5398.946010539898, 5422.728863556821, 5214.973925130378, 5388.110961691326, 5401.78392864285, 5403.70279634621, 5422.213779002042, 4108.917821643573, 4112.485939257593, 4116.670666346685, 4117.608827161415, 4128.8348466061325, 3897.7661340319673, 3988.1824226033596, 4023.436718859362, 4109.609587089237, 4112.568180341066, 4082.5713300103507, 4093.406456063869, 4096.446979657752, 4099.979500102495, 4101.5488296287385, 4063.0654949361515, 4064.9390259146135, 4073.429719839225, 4080.489938757655, 4085.5914408558906, 3537.663921927413, 3537.823108844573, 3537.964620353789, 3544.220271540257, 3544.805035723034, 5107.744612769384, 5194.818181363634, 5238.633295669305, 5241.606879484016, 5247.16045432729, 4710.081534100852, 4716.50476699945, 4716.669833111683, 4719.244920812688, 4724.976375118103, 5666.914996275059, 5670.0, 5670.06443936754, 5672.064109421982, 5673.205751194836, 3865.4781604483314, 3876.089119057019, 3876.612338766129, 3877.224555088965, 3877.5346958365176, 5494.890102197974, 5608.074667679869, 5964.135200395918, 5973.074173503114, 5979.19280897082, 3842.7886466244067, 3951.9527325258828, 3955.8132560231816, 3956.5647778744315, 3957.5448823385677, 4014.5583985762128, 4024.4566983457444, 4027.4160246764054, 4029.91940161201, 4032.9798351008058, 4646.163690535668, 4657.0, 4657.5575320344515, 4660.324252983366, 4667.206574882278, 5668.149777533403, 5676.347220069662, 5680.857978550486, 5681.403452637496, 5681.545476361881, 1328.3955800110925, 1376.7728324826492, 1377.0, 1377.9862201378057, 1378.7793952967677, 890.1988210610373, 902.9593668284942, 907.9636814527477, 909.1544863277084, 919.2186641354795, 4958.107540642719, 4971.1549036663855, 4977.9751101244265, 4982.0, 4986.052649996562, 5858.238429004287, 5864.501517370986, 5871.911921321183, 5875.6180848245585, 5877.265341832271, 4835.0571638530855, 4869.196582563908, 4977.427595826454, 4982.750862456863, 4985.675931064469, 3141.858616362269, 3159.0838656789274, 3163.873445062218, 3167.0815463515783, 3170.0648308748973, 5611.298587676541, 5631.943680563142, 5644.6613203207935, 5646.576506761927, 5651.208830763697, 5957.910631340534, 6091.725872335755, 6113.541484388688, 6117.816465506042, 6132.478739307119, 5643.266375371176, 5645.266115405053, 5661.150827375926, 5664.291963504562, 5668.433156684381, 5940.376260492586, 5948.048312270016, 5951.1073338999495, 5963.105534169909, 5973.313068997121, 5702.144678298288, 5829.0, 5833.416658334133, 5836.270466191726, 5839.416058394127, 5634.943650563442, 5638.9436105638415, 5647.745851436777, 5648.745806438638, 5656.915146272891, 3874.205787813548, 3907.335752922067, 3908.1792823506244, 3914.0801911551334, 3915.0799562103452, 5938.376470470538, 5943.019401798655, 5946.286445626552, 5946.345901950868, 5946.762129514771, 5571.0, 5675.205471234113, 5690.743916523684, 5694.572907032072, 5697.943020569741, 5649.689267090185, 5651.180578816131, 5652.434756524314, 5653.180288858175, 5662.178984047372, 5563.443655634404, 5567.916481252703, 5569.637973531708, 5576.470235327637, 5588.888222235614, 5623.971880140573, 5730.541556675373, 5739.5695322850115, 5740.253767010262, 5745.683987380567, 5522.282103326542, 5553.333599967868, 5568.276124103841, 5573.909783831064, 5577.191307260344], "unit": "ms", "name": "prototype.html", "value": 4206.189568216437}, {"lowerIsBetter": false, "replicates": [620.857202843346, 721.967511461984, 745.7613563659628, 753.472569201559, 766.4902839611663, 11577.53689852406, 11727.237729547584, 11736.941315293423, 11748.530058797638, 11778.646640600775, 11815.0, 12049.277043377404, 12135.696607584814, 12141.817872731915, 12145.08911831614, 609.2658346692248, 616.6207782213951, 779.0612312163843, 780.4302858912997, 797.4696826610326, 791.0586402181415, 800.4076983032572, 800.7998000499875, 803.2369249213242, 803.6704950970103, 632.8892443822335, 762.6834863531656, 816.5264146794874, 839.7690635075342, 840.1472505407016, 640.6188317950812, 790.9881351779728, 801.5711594297081, 802.5385403393072, 803.5419810707899, 601.5518438763106, 603.4599033864666, 603.6136872401667, 603.9063945088518, 603.9486643635296, 12021.218620789621, 12285.754284914341, 12299.139060265785, 12328.19866708661, 12332.383380830923, 11054.613088541862, 11392.658220253406, 11490.482928268248, 11923.403829808562, 12510.061745369134, 9947.303688741791, 9968.302218844683, 10006.69979900604, 10014.0, 10040.246981476346, 3172.4289627866974, 3224.6614105518815, 3228.3059142284287, 3285.1458620758535, 3291.424000799874, 40976.180476390604, 41028.589714102774, 41028.589714102774, 41137.17725645471, 41284.79357603223, 9635.22918166545, 9641.132298093065, 9817.312788104764, 9818.067283608047, 9844.261680374, 10795.46022698862, 10914.617988370368, 10925.890741092646, 10929.672109836718, 10930.398828064534, 5269.077911365495, 5329.467053294717, 5530.6128570999645, 5590.440955904377, 5595.776168953278, 3336.132605522582, 3393.372226138123, 3408.2672225471147, 3409.9147521312166, 3410.1474631342167, 2498.375406148463, 2601.0, 2603.8177327586886, 2608.960865587018, 2611.3732704150866, 397.715633322176, 400.74953154278575, 402.0692097793598, 402.94157347184495, 404.561051259381, 408.8609872643256, 451.7238800388914, 463.96998662968156, 479.11124863378626, 515.9593806495302, 7478.102627684604, 7549.433792465587, 7562.697492100255, 7599.430042746816, 7922.207779222032, 386.5805600922974, 429.93550967355145, 569.7663957777374, 609.4910749524197, 609.5428428678491, 3785.4511095890944, 3789.696824254053, 3885.1452680410266, 3914.8042597869994, 3954.6045395460224, 51808.0, 52511.212331815055, 52602.73698631483, 52604.0, 52783.472165278625, 42536.78731606322, 42764.57235427668, 43505.12989740187, 43527.78236108799, 45328.773356133664, 38851.41722874159, 39423.408648869714, 41324.38013429801, 41693.0, 41747.7912610435, 8166.795830104057, 8243.093259741303, 8265.297449716842, 8326.45878017927, 8401.285890699115, 32306.19234519062, 32615.0, 32951.17622059468, 33025.33949321048, 33240.0, 40353.19293614053, 41442.0, 41848.0, 41948.161036779704, 42288.577114228465, 6674.299198584079, 6763.323667633197, 6909.827254318682, 7304.926950730637, 7413.147488038944, 11647.184697071123, 11840.70398240051, 11957.581484647995, 11989.1008174389, 12413.93793031029, 9999.450030248407, 10491.422971736627, 10599.15206783471, 10731.356118632906, 10880.782384352111, 10614.097801686634, 10642.308249963728, 10707.304025238334, 10746.301490403099, 10904.781904362027, 7856.968986433153, 9978.650747223812, 11093.33439993603, 11373.090152787923, 11459.656210313371, 8996.64013439455, 9186.908130918606, 9335.206507446672, 9538.475383853955, 9641.325107242426, 9327.533623318943, 9658.613655453702, 9847.655332063343, 9858.359206651545, 9860.26048046385], "unit": "ms", "name": "yui.html", "value": 5531.2297961192135}], "name": "dromaeo_css", "value": 5905.761569972515}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 109.0, 113.0, 112.0, 114.0, 120.0, 112.0, 112.0, 112.0, 112.0], "unit": "ms", "name": "ai-astar", "value": 113.0}, {"lowerIsBetter": true, "replicates": [167.0, 133.0, 154.0, 164.0, 129.0, 151.0, 154.0, 131.0, 173.0, 130.0], "unit": "ms", "name": "audio-beat-detection", "value": 148.6}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 161.0, 161.0, 162.0, 160.0, 165.0, 161.0, 162.0, 163.0], "unit": "ms", "name": "audio-dft", "value": 162.0}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 84.0, 89.0, 72.0, 72.0, 72.0, 110.0, 89.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 80.5}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 136.0, 91.0, 91.0, 90.0, 126.0, 91.0, 92.0, 126.0], "unit": "ms", "name": "audio-oscillator", "value": 102.8}, {"lowerIsBetter": true, "replicates": [110.0, 111.0, 109.0, 110.0, 109.0, 110.0, 111.0, 110.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 148.0, 148.0, 148.0, 148.0, 148.0, 149.0, 147.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.8}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 72.0, 73.0, 71.0, 71.0, 72.0, 81.0, 70.0, 72.0], "unit": "ms", "name": "json-parse-financial", "value": 72.7}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 70.0, 69.0, 70.0, 69.0, 69.0, 69.0, 69.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.4}, {"lowerIsBetter": true, "replicates": [83.0, 90.0, 84.0, 86.0, 83.0, 86.0, 84.0, 83.0, 85.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.8}, {"lowerIsBetter": true, "replicates": [120.0, 124.0, 132.0, 122.0, 134.0, 132.0, 130.0, 121.0, 122.0, 130.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 126.7}, {"lowerIsBetter": true, "replicates": [142.0, 144.0, 155.0, 156.0, 152.0, 141.0, 152.0, 151.0, 152.0, 142.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 148.7}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 68.0, 70.0, 71.0, 69.0, 70.0, 69.0, 69.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.6}], "name": "kraken", "value": 1531.9}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.257555847569], "unit": "score", "name": "Richards", "value": 214.918576}, {"lowerIsBetter": false, "replicates": [185.6665428889714], "unit": "score", "name": "DeltaBlue", "value": 356.111548}, {"lowerIsBetter": false, "replicates": [279.4857462269424], "unit": "score", "name": "Encrypt", "value": 952.3956179999999}, {"lowerIsBetter": false, "replicates": [5040.201005025126], "unit": "score", "name": "Decrypt", "value": 52.81158424725827}, {"lowerIsBetter": false, "replicates": [2014.0845070422536], "unit": "score", "name": "RayTrace", "value": 367.4071258741258}, {"lowerIsBetter": false, "replicates": [783.0853563038371], "unit": "score", "name": "Earley", "value": 851.0732510000003}, {"lowerIsBetter": false, "replicates": [12120.481927710844], "unit": "score", "name": "Boyer", "value": 54.9865099403579}, {"lowerIsBetter": false, "replicates": [26447.36842105263], "unit": "score", "name": "RegExp", "value": 34.44520398009948}, {"lowerIsBetter": false, "replicates": [610.738255033557], "unit": "score", "name": "Splay", "value": 133.43031868131865}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 19895.670539619554}]} 07:54:50 INFO - RETURN: dromaeo_css: 5905.76 07:54:50 INFO - RETURN: kraken: 1531.90 07:54:50 INFO - RETURN: v8_7: 19895.67 07:54:50 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19895.67"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1531.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "5905.76"}}} 07:54:50 INFO - Return code: 0 07:54:50 INFO - # TBPL SUCCESS # 07:54:50 INFO - Running post-action listener: _resource_record_post_action 07:54:50 INFO - Running post-run listener: _resource_record_post_run 07:54:51 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 495616; Write bytes: 337006592; Read time: 92; Write time: 267860 07:54:51 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 56209408; Read time: 0; Write time: 52772 07:54:51 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 491520; Write bytes: 268042240; Read time: 48; Write time: 213676 07:54:51 INFO - Running post-run listener: _upload_blobber_files 07:54:51 INFO - Blob upload gear active. 07:54:51 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 07:54:51 INFO - Copying logs to upload dir... 07:54:51 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1266.735793 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-11-18 07:54:51.824251) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-18 07:54:51.828260) ========= 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=6d5287d839824eebc594b0c9000001d1-1447859883.469125-1934920036 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/HSYjftOxQF-CX1F5o09Qog/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.008857 build_url: 'https://queue.taskcluster.net/v1/task/HSYjftOxQF-CX1F5o09Qog/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 07:54:51.878549) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 07:54:51.878951) ========= 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=6d5287d839824eebc594b0c9000001d1-1447859883.469125-1934920036 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004518 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 07:54:51.928715) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 07:54:51.929058) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 07:54:51.929348) ========= ========= Total master_lag: 0.23 =========