builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-001 starttime: 1448298457.92 results: success (0) buildid: 20151123083130 builduid: 42649fd7ec914a07860f14dd62326a45 revision: 29f87d064607ef5683b5aec9eb7d0b732b101c08 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 09:07:37.920262) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 09:07:37.920749) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 09:07:37.921032) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1448298236.934799-708591809 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006525 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 09:07:37.942746) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 09:07:37.943182) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 09:07:37.956780) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 09:07:37.957157) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1448298236.934799-708591809 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004682 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 09:07:38.010481) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 09:07:38.010793) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 09:07:38.011222) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 09:07:38.011582) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1448298236.934799-708591809 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-23 09:07:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 47.7M=0s 2015-11-23 09:07:38 (47.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.174709 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 09:07:38.204682) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 09:07:38.204993) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1448298236.934799-708591809 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016659 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 09:07:38.254929) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-23 09:07:38.255279) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 29f87d064607ef5683b5aec9eb7d0b732b101c08 --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 29f87d064607ef5683b5aec9eb7d0b732b101c08 --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=b4e1481c633df10bed3f4cc0000001c7-1448298236.934799-708591809 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-23 09:07:38,611 truncating revision to first 12 chars 2015-11-23 09:07:38,611 Setting DEBUG logging. 2015-11-23 09:07:38,611 attempt 1/10 2015-11-23 09:07:38,611 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/29f87d064607?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-23 09:07:39,766 unpacking tar archive at: fx-team-29f87d064607/testing/mozharness/ program finished with exit code 0 elapsedTime=1.420254 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-23 09:07:39.688795) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 09:07:39.689111) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 09:07:39.698581) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 09:07:39.698985) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 09:07:39.699449) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-11-23 09:07:39.699775) ========= /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=b4e1481c633df10bed3f4cc0000001c7-1448298236.934799-708591809 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:07:40 INFO - MultiFileLogger online at 20151123 09:07:40 in /builds/slave/test 09:07:40 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 09:07:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:07:40 INFO - {'append_to_log': False, 09:07:40 INFO - 'base_work_dir': '/builds/slave/test', 09:07:40 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:07:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:07:40 INFO - 'branch': 'Fx-Team-Non-PGO', 09:07:40 INFO - 'buildbot_json_path': 'buildprops.json', 09:07:40 INFO - 'config_files': ('talos/linux_config.py',), 09:07:40 INFO - 'default_actions': ('clobber', 09:07:40 INFO - 'read-buildbot-config', 09:07:40 INFO - 'download-and-extract', 09:07:40 INFO - 'populate-webroot', 09:07:40 INFO - 'create-virtualenv', 09:07:40 INFO - 'install', 09:07:40 INFO - 'run-tests'), 09:07:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:07:40 INFO - 'download_minidump_stackwalk': True, 09:07:40 INFO - 'download_symbols': 'ondemand', 09:07:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:07:40 INFO - 'tooltool.py': '/tools/tooltool.py', 09:07:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:07:40 INFO - '/tools/misc-python/virtualenv.py')}, 09:07:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:07:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:07:40 INFO - 'installer_path': 'installer.exe', 09:07:40 INFO - 'log_level': 'info', 09:07:40 INFO - 'log_name': 'talos', 09:07:40 INFO - 'log_to_console': True, 09:07:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:07:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:07:40 INFO - 'opt_config_files': (), 09:07:40 INFO - 'pip_index': False, 09:07:40 INFO - 'sps_profile': False, 09:07:40 INFO - 'sps_profile_interval': 0, 09:07:40 INFO - 'suite': 'dromaeojs', 09:07:40 INFO - 'system_bits': '64', 09:07:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:07:40 INFO - 'title': 'talos-linux64-ix-001', 09:07:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:07:40 INFO - 'use_talos_json': True, 09:07:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:07:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:07:40 INFO - 'work_dir': 'build'} 09:07:40 INFO - ##### 09:07:40 INFO - ##### Running clobber step. 09:07:40 INFO - ##### 09:07:40 INFO - Running pre-action listener: _resource_record_pre_action 09:07:40 INFO - Running main action method: clobber 09:07:40 INFO - rmtree: /builds/slave/test/build 09:07:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:07:41 INFO - Running post-action listener: _resource_record_post_action 09:07:41 INFO - ##### 09:07:41 INFO - ##### Running read-buildbot-config step. 09:07:41 INFO - ##### 09:07:41 INFO - Running pre-action listener: _resource_record_pre_action 09:07:41 INFO - Running main action method: read_buildbot_config 09:07:41 INFO - Using buildbot properties: 09:07:41 INFO - { 09:07:41 INFO - "properties": { 09:07:41 INFO - "buildnumber": 2103, 09:07:41 INFO - "product": "firefox", 09:07:41 INFO - "script_repo_revision": "production", 09:07:41 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 09:07:41 INFO - "repository": "", 09:07:41 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 09:07:41 INFO - "buildid": "20151123083130", 09:07:41 INFO - "slavename": "talos-linux64-ix-001", 09:07:41 INFO - "pgo_build": "False", 09:07:41 INFO - "basedir": "/builds/slave/test", 09:07:41 INFO - "project": "", 09:07:41 INFO - "platform": "ubuntu64_hw", 09:07:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:07:41 INFO - "slavebuilddir": "test", 09:07:41 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:07:41 INFO - "branch": "fx-team", 09:07:41 INFO - "repo_path": "integration/fx-team", 09:07:41 INFO - "stage_platform": "linux64", 09:07:41 INFO - "builduid": "42649fd7ec914a07860f14dd62326a45", 09:07:41 INFO - "revision": "29f87d064607ef5683b5aec9eb7d0b732b101c08" 09:07:41 INFO - }, 09:07:41 INFO - "sourcestamp": { 09:07:41 INFO - "repository": "", 09:07:41 INFO - "hasPatch": false, 09:07:41 INFO - "project": "", 09:07:41 INFO - "branch": "fx-team-linux64-talos", 09:07:41 INFO - "changes": [ 09:07:41 INFO - { 09:07:41 INFO - "category": null, 09:07:41 INFO - "files": [ 09:07:41 INFO - { 09:07:41 INFO - "url": null, 09:07:41 INFO - "name": "https://queue.taskcluster.net/v1/task/rgWqqQjYRByA4tSThUtIJA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 09:07:41 INFO - } 09:07:41 INFO - ], 09:07:41 INFO - "repository": "", 09:07:41 INFO - "rev": "29f87d064607ef5683b5aec9eb7d0b732b101c08", 09:07:41 INFO - "who": "mbanner@mozilla.com", 09:07:41 INFO - "when": 1448298425, 09:07:41 INFO - "number": 6695770, 09:07:41 INFO - "comments": "Bug 1227109. Tidy loop conversation window styles, remove temporarily work arounds that are no longer required and fix layout of standalone UI when in narrow views. r=mikedeboer", 09:07:41 INFO - "project": "", 09:07:41 INFO - "at": "Mon 23 Nov 2015 09:07:05", 09:07:41 INFO - "branch": "fx-team-linux64-talos", 09:07:41 INFO - "revlink": "", 09:07:41 INFO - "properties": [ 09:07:41 INFO - [ 09:07:41 INFO - "buildid", 09:07:41 INFO - "20151123083130", 09:07:41 INFO - "Change" 09:07:41 INFO - ], 09:07:41 INFO - [ 09:07:41 INFO - "builduid", 09:07:41 INFO - "42649fd7ec914a07860f14dd62326a45", 09:07:41 INFO - "Change" 09:07:41 INFO - ], 09:07:41 INFO - [ 09:07:41 INFO - "pgo_build", 09:07:41 INFO - "False", 09:07:41 INFO - "Change" 09:07:41 INFO - ] 09:07:41 INFO - ], 09:07:41 INFO - "revision": "29f87d064607ef5683b5aec9eb7d0b732b101c08" 09:07:41 INFO - } 09:07:41 INFO - ], 09:07:41 INFO - "revision": "29f87d064607ef5683b5aec9eb7d0b732b101c08" 09:07:41 INFO - } 09:07:41 INFO - } 09:07:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/rgWqqQjYRByA4tSThUtIJA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 09:07:41 INFO - Running post-action listener: _resource_record_post_action 09:07:41 INFO - ##### 09:07:41 INFO - ##### Running download-and-extract step. 09:07:41 INFO - ##### 09:07:41 INFO - Running pre-action listener: _resource_record_pre_action 09:07:41 INFO - Running main action method: download_and_extract 09:07:41 INFO - mkdir: /builds/slave/test/build/tests 09:07:41 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')]} 09:07:41 INFO - https://queue.taskcluster.net/v1/task/rgWqqQjYRByA4tSThUtIJA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:07:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rgWqqQjYRByA4tSThUtIJA/artifacts/public/build/test_packages.json 09:07:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rgWqqQjYRByA4tSThUtIJA/artifacts/public/build/test_packages.json 09:07:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rgWqqQjYRByA4tSThUtIJA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 09:07:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rgWqqQjYRByA4tSThUtIJA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 09:07:47 INFO - Downloaded 1302 bytes. 09:07:47 INFO - Reading from file /builds/slave/test/build/test_packages.json 09:07:47 INFO - Using the following test package requirements: 09:07:47 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:07:47 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:07:47 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:07:47 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:07:47 INFO - u'jsshell-linux-x86_64.zip'], 09:07:47 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:07:47 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:07:47 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:07:47 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:07:47 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:07:47 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:07:47 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:07:47 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:07:47 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:07:47 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:07:47 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:07:47 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:07:47 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:07:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:47 INFO - https://queue.taskcluster.net/v1/task/rgWqqQjYRByA4tSThUtIJA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:07:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rgWqqQjYRByA4tSThUtIJA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:07:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rgWqqQjYRByA4tSThUtIJA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:07:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rgWqqQjYRByA4tSThUtIJA/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 09:07:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rgWqqQjYRByA4tSThUtIJA/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 09:07:50 INFO - Downloaded 21341275 bytes. 09:07: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 09:07:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:07: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 09:07:51 INFO - Return code: 0 09:07:51 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:07: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')]} 09:07:51 INFO - https://queue.taskcluster.net/v1/task/rgWqqQjYRByA4tSThUtIJA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:07:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rgWqqQjYRByA4tSThUtIJA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:07:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rgWqqQjYRByA4tSThUtIJA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:07:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rgWqqQjYRByA4tSThUtIJA/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 09:07:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rgWqqQjYRByA4tSThUtIJA/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 09:07:55 INFO - Downloaded 21341275 bytes. 09:07:55 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 09:07:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:07:55 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 09:07:56 INFO - Return code: 0 09:07:56 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')]} 09:07:56 INFO - https://queue.taskcluster.net/v1/task/rgWqqQjYRByA4tSThUtIJA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:07:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rgWqqQjYRByA4tSThUtIJA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:07:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rgWqqQjYRByA4tSThUtIJA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:07:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rgWqqQjYRByA4tSThUtIJA/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 09:07:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rgWqqQjYRByA4tSThUtIJA/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 09:07:57 INFO - Downloaded 11130997 bytes. 09:07:57 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 09:07:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:07:57 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 09:07:57 INFO - Return code: 0 09:07:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:57 INFO - https://queue.taskcluster.net/v1/task/rgWqqQjYRByA4tSThUtIJA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:07:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rgWqqQjYRByA4tSThUtIJA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:07:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rgWqqQjYRByA4tSThUtIJA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:07:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rgWqqQjYRByA4tSThUtIJA/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 09:07:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rgWqqQjYRByA4tSThUtIJA/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 09:07:59 INFO - Downloaded 56024011 bytes. 09:07:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/rgWqqQjYRByA4tSThUtIJA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:07:59 INFO - mkdir: /builds/slave/test/properties 09:07:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:07:59 INFO - Writing to file /builds/slave/test/properties/build_url 09:07:59 INFO - Contents: 09:07:59 INFO - build_url:https://queue.taskcluster.net/v1/task/rgWqqQjYRByA4tSThUtIJA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:07:59 INFO - Running post-action listener: _resource_record_post_action 09:07:59 INFO - Running post-action listener: set_extra_try_arguments 09:07:59 INFO - ##### 09:07:59 INFO - ##### Running populate-webroot step. 09:07:59 INFO - ##### 09:07:59 INFO - Running pre-action listener: _resource_record_pre_action 09:07:59 INFO - Running main action method: populate_webroot 09:07:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:07:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:07:59 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 09:07:59 INFO - '../fennec_ids.txt'], 09:07:59 INFO - 'tests': ['tcheck2']}, 09:07:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:07:59 INFO - '--tppagecycles', 09:07:59 INFO - '7'], 09:07:59 INFO - 'tests': ['tsvgm']}}, 09:07:59 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:07:59 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:07:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:07:59 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:07:59 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:07:59 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:07:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:07:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:07:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:07:59 INFO - 'talos_options': ['--e10s'], 09:07:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:07:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:07:59 INFO - 'tests': ['damp', 'tps']}, 09:07:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:07:59 INFO - 'talos_options': ['--e10s'], 09:07:59 INFO - 'tests': ['damp', 'tps']}, 09:07:59 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:07:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:07:59 INFO - 'other': {'tests': ['a11yr', 09:07:59 INFO - 'ts_paint', 09:07:59 INFO - 'tpaint', 09:07:59 INFO - 'sessionrestore', 09:07:59 INFO - 'sessionrestore_no_auto_restore']}, 09:07:59 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:07:59 INFO - 'tests': ['a11yr', 09:07:59 INFO - 'ts_paint', 09:07:59 INFO - 'tpaint', 09:07:59 INFO - 'sessionrestore', 09:07:59 INFO - 'sessionrestore_no_auto_restore']}, 09:07:59 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:07:59 INFO - 'tests': ['a11yr', 09:07:59 INFO - 'ts_paint', 09:07:59 INFO - 'tpaint', 09:07:59 INFO - 'sessionrestore', 09:07:59 INFO - 'sessionrestore_no_auto_restore']}, 09:07:59 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:07:59 INFO - 'tests': ['a11yr', 09:07:59 INFO - 'ts_paint', 09:07:59 INFO - 'tpaint', 09:07:59 INFO - 'sessionrestore', 09:07:59 INFO - 'sessionrestore_no_auto_restore']}, 09:07:59 INFO - 'other_l64': {'tests': ['a11yr', 09:07:59 INFO - 'ts_paint', 09:07:59 INFO - 'tpaint', 09:07:59 INFO - 'sessionrestore', 09:07:59 INFO - 'sessionrestore_no_auto_restore']}, 09:07:59 INFO - 'other_nol64': {'tests': ['a11yr', 09:07:59 INFO - 'ts_paint', 09:07:59 INFO - 'tpaint', 09:07:59 INFO - 'sessionrestore', 09:07:59 INFO - 'sessionrestore_no_auto_restore']}, 09:07:59 INFO - 'svgr': {'tests': ['tsvgx', 09:07:59 INFO - 'tsvgr_opacity', 09:07:59 INFO - 'tart', 09:07:59 INFO - 'tscrollx', 09:07:59 INFO - 'cart']}, 09:07:59 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:07:59 INFO - 'tests': ['tsvgx', 09:07:59 INFO - 'tsvgr_opacity', 09:07:59 INFO - 'tart', 09:07:59 INFO - 'tscrollx', 09:07:59 INFO - 'cart']}, 09:07:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:07:59 INFO - 'tests': ['tp5o']}, 09:07:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:07:59 INFO - 'talos_options': ['--e10s'], 09:07:59 INFO - 'tests': ['tp5o']}, 09:07:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:07:59 INFO - 'talos_options': ['--xperf_path', 09:07:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:07:59 INFO - 'tests': ['tp5n']}, 09:07:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:07:59 INFO - 'talos_options': ['--e10s', 09:07:59 INFO - '--xperf_path', 09:07:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:07:59 INFO - 'tests': ['tp5n']}}, 09:07:59 INFO - 'talos.zip': {'path': '', 09:07:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:07:59 INFO - Running post-action listener: _resource_record_post_action 09:07:59 INFO - ##### 09:07:59 INFO - ##### Running create-virtualenv step. 09:07:59 INFO - ##### 09:07:59 INFO - Running pre-action listener: _resource_record_pre_action 09:07:59 INFO - Running main action method: create_virtualenv 09:07:59 INFO - Creating virtualenv /builds/slave/test/build/venv 09:07:59 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:07:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:07:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:07:59 INFO - Using real prefix '/usr' 09:07:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:08:00 INFO - Installing distribute.............................................................................................................................................................................................done. 09:08:02 INFO - Installing pip.................done. 09:08:02 INFO - Return code: 0 09:08:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:08:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:08:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:08:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:08:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7ee3afc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18cd6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197e900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c4b70>, '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 0x1a15dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a16250>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1448298236.934799-708591809', '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 09:08:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:08:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:08:02 INFO - Using env: {'DISPLAY': ':0', 09:08:02 INFO - 'HOME': '/home/cltbld', 09:08:02 INFO - 'LANG': 'en_US.UTF-8', 09:08:02 INFO - 'LANGUAGE': 'en_US:en', 09:08:02 INFO - 'LOGNAME': 'cltbld', 09:08:02 INFO - 'MAIL': '/var/mail/cltbld', 09:08:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:02 INFO - 'MOZ_NO_REMOTE': '1', 09:08:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:02 INFO - 'NO_EM_RESTART': '1', 09:08:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:08:02 INFO - 'PWD': '/builds/slave/test', 09:08:02 INFO - 'SHELL': '/bin/bash', 09:08:02 INFO - 'SHLVL': '1', 09:08:02 INFO - 'TERM': 'linux', 09:08:02 INFO - 'TMOUT': '86400', 09:08:02 INFO - 'USER': 'cltbld', 09:08:02 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1448298236.934799-708591809', 09:08:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:02 INFO - '_': '/tools/buildbot/bin/python'} 09:08:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:08:02 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 09:08:02 INFO - Cleaning up... 09:08:02 INFO - Return code: 0 09:08:02 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:08:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:08:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:08:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:08:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7ee3afc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18cd6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197e900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c4b70>, '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 0x1a15dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a16250>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1448298236.934799-708591809', '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 09:08:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 09:08:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:08:02 INFO - Using env: {'DISPLAY': ':0', 09:08:02 INFO - 'HOME': '/home/cltbld', 09:08:02 INFO - 'LANG': 'en_US.UTF-8', 09:08:02 INFO - 'LANGUAGE': 'en_US:en', 09:08:02 INFO - 'LOGNAME': 'cltbld', 09:08:02 INFO - 'MAIL': '/var/mail/cltbld', 09:08:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:02 INFO - 'MOZ_NO_REMOTE': '1', 09:08:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:02 INFO - 'NO_EM_RESTART': '1', 09:08:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:08:02 INFO - 'PWD': '/builds/slave/test', 09:08:02 INFO - 'SHELL': '/bin/bash', 09:08:02 INFO - 'SHLVL': '1', 09:08:02 INFO - 'TERM': 'linux', 09:08:02 INFO - 'TMOUT': '86400', 09:08:02 INFO - 'USER': 'cltbld', 09:08:02 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1448298236.934799-708591809', 09:08:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:02 INFO - '_': '/tools/buildbot/bin/python'} 09:08:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:08:02 INFO - Downloading/unpacking psutil>=0.7.1 09:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:08:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:08:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:08:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:08:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:08:04 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 09:08:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 09:08:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:08:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:08:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:08:04 INFO - Installing collected packages: psutil 09:08:04 INFO - Running setup.py install for psutil 09:08:04 INFO - building 'psutil._psutil_linux' extension 09:08:04 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:08: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 09:08:04 INFO - building 'psutil._psutil_posix' extension 09:08: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 09:08: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 09:08:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:08:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:08:04 INFO - Successfully installed psutil 09:08:05 INFO - Cleaning up... 09:08:05 INFO - Return code: 0 09:08:05 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:08:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:08:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:08:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:08:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:08:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:05 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 0x7ff7ee3afc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18cd6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197e900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c4b70>, '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 0x1a15dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a16250>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1448298236.934799-708591809', '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 09:08:05 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 09:08:05 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 09:08:05 INFO - Using env: {'DISPLAY': ':0', 09:08:05 INFO - 'HOME': '/home/cltbld', 09:08:05 INFO - 'LANG': 'en_US.UTF-8', 09:08:05 INFO - 'LANGUAGE': 'en_US:en', 09:08:05 INFO - 'LOGNAME': 'cltbld', 09:08:05 INFO - 'MAIL': '/var/mail/cltbld', 09:08:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:05 INFO - 'MOZ_NO_REMOTE': '1', 09:08:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:05 INFO - 'NO_EM_RESTART': '1', 09:08:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:08:05 INFO - 'PWD': '/builds/slave/test', 09:08:05 INFO - 'SHELL': '/bin/bash', 09:08:05 INFO - 'SHLVL': '1', 09:08:05 INFO - 'TERM': 'linux', 09:08:05 INFO - 'TMOUT': '86400', 09:08:05 INFO - 'USER': 'cltbld', 09:08:05 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1448298236.934799-708591809', 09:08:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:05 INFO - '_': '/tools/buildbot/bin/python'} 09:08:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:08:05 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:08:05 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 09:08:05 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 09:08:05 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 09:08:05 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 09:08:05 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 09:08:05 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 09:08:06 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:08:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 09:08:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:08: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) 09:08:06 INFO - Installing collected packages: mozsystemmonitor 09:08:06 INFO - Running setup.py install for mozsystemmonitor 09:08:07 INFO - Successfully installed mozsystemmonitor 09:08:07 INFO - Cleaning up... 09:08:07 INFO - Return code: 0 09:08:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:08:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:08:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:08:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:08:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:07 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 0x7ff7ee3afc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18cd6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197e900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c4b70>, '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 0x1a15dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a16250>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1448298236.934799-708591809', '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 09:08:07 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 09:08:07 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 09:08:07 INFO - Using env: {'DISPLAY': ':0', 09:08:07 INFO - 'HOME': '/home/cltbld', 09:08:07 INFO - 'LANG': 'en_US.UTF-8', 09:08:07 INFO - 'LANGUAGE': 'en_US:en', 09:08:07 INFO - 'LOGNAME': 'cltbld', 09:08:07 INFO - 'MAIL': '/var/mail/cltbld', 09:08:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:07 INFO - 'MOZ_NO_REMOTE': '1', 09:08:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:07 INFO - 'NO_EM_RESTART': '1', 09:08:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:08:07 INFO - 'PWD': '/builds/slave/test', 09:08:07 INFO - 'SHELL': '/bin/bash', 09:08:07 INFO - 'SHLVL': '1', 09:08:07 INFO - 'TERM': 'linux', 09:08:07 INFO - 'TMOUT': '86400', 09:08:07 INFO - 'USER': 'cltbld', 09:08:07 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1448298236.934799-708591809', 09:08:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:07 INFO - '_': '/tools/buildbot/bin/python'} 09:08:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:08:07 INFO - Downloading/unpacking blobuploader==1.2.4 09:08:07 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 09:08:07 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 09:08:07 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 09:08:07 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 09:08:07 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 09:08:07 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 09:08:08 INFO - Downloading blobuploader-1.2.4.tar.gz 09:08:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 09:08:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:08:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:08:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:08:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:08:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:08:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:08:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 09:08:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:08:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:08:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:08:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:08:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:08:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:08:09 INFO - Downloading docopt-0.6.1.tar.gz 09:08:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 09:08:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:08:09 INFO - Installing collected packages: blobuploader, requests, docopt 09:08:09 INFO - Running setup.py install for blobuploader 09:08:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:08:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:08:09 INFO - Running setup.py install for requests 09:08:10 INFO - Running setup.py install for docopt 09:08:10 INFO - Successfully installed blobuploader requests docopt 09:08:10 INFO - Cleaning up... 09:08:10 INFO - Return code: 0 09:08:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:08:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:08:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:08:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:08:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:08:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:10 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 0x7ff7ee3afc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18cd6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197e900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c4b70>, '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 0x1a15dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a16250>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1448298236.934799-708591809', '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 09:08:10 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 09:08:10 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 09:08:10 INFO - Using env: {'DISPLAY': ':0', 09:08:10 INFO - 'HOME': '/home/cltbld', 09:08:10 INFO - 'LANG': 'en_US.UTF-8', 09:08:10 INFO - 'LANGUAGE': 'en_US:en', 09:08:10 INFO - 'LOGNAME': 'cltbld', 09:08:10 INFO - 'MAIL': '/var/mail/cltbld', 09:08:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:10 INFO - 'MOZ_NO_REMOTE': '1', 09:08:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:10 INFO - 'NO_EM_RESTART': '1', 09:08:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:08:10 INFO - 'PWD': '/builds/slave/test', 09:08:10 INFO - 'SHELL': '/bin/bash', 09:08:10 INFO - 'SHLVL': '1', 09:08:10 INFO - 'TERM': 'linux', 09:08:10 INFO - 'TMOUT': '86400', 09:08:10 INFO - 'USER': 'cltbld', 09:08:10 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1448298236.934799-708591809', 09:08:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:10 INFO - '_': '/tools/buildbot/bin/python'} 09:08:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:08:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:08:10 INFO - Running setup.py (path:/tmp/pip-e5Niy2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:08:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:08:10 INFO - Running setup.py (path:/tmp/pip-7vV2OF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:08:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:08:10 INFO - Running setup.py (path:/tmp/pip-X23soG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:08:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:08:10 INFO - Running setup.py (path:/tmp/pip-o3LNQc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:08:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:08:10 INFO - Running setup.py (path:/tmp/pip-1yBDx2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:08:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:08:10 INFO - Running setup.py (path:/tmp/pip-peG7n5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:08:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:08:10 INFO - Running setup.py (path:/tmp/pip-eyaZIF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:08:11 INFO - Running setup.py (path:/tmp/pip-D4jyff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:08:11 INFO - Running setup.py (path:/tmp/pip-nQ6e2q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:08:11 INFO - Running setup.py (path:/tmp/pip-HB3JA8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:08:11 INFO - Running setup.py (path:/tmp/pip-W4YsKG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:08:11 INFO - Running setup.py (path:/tmp/pip-7kkr7X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:08:11 INFO - Running setup.py (path:/tmp/pip-AHrh5w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:08:11 INFO - Running setup.py (path:/tmp/pip-XT3PsR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:08:11 INFO - Running setup.py (path:/tmp/pip-2XecSa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:08:11 INFO - Running setup.py (path:/tmp/pip-IB78Ce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:08:11 INFO - Running setup.py (path:/tmp/pip-wM_wEg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:08:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:08:11 INFO - Running setup.py install for manifestparser 09:08:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:08:11 INFO - Running setup.py install for mozcrash 09:08:11 INFO - Running setup.py install for mozdebug 09:08:12 INFO - Running setup.py install for mozdevice 09:08:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:08:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:08:12 INFO - Running setup.py install for mozfile 09:08:12 INFO - Running setup.py install for mozhttpd 09:08:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:08:12 INFO - Running setup.py install for mozinfo 09:08:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:08:12 INFO - Running setup.py install for mozInstall 09:08:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:08:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:08:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:08:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:08:12 INFO - Running setup.py install for mozleak 09:08:12 INFO - Running setup.py install for mozlog 09:08:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:08:12 INFO - Running setup.py install for moznetwork 09:08:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:08:12 INFO - Running setup.py install for mozprocess 09:08:12 INFO - Running setup.py install for mozprofile 09:08:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:08:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:08:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:08:13 INFO - Running setup.py install for mozrunner 09:08:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:08:13 INFO - Running setup.py install for mozscreenshot 09:08:13 INFO - Running setup.py install for moztest 09:08:13 INFO - Running setup.py install for mozversion 09:08:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:08:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:08:13 INFO - Cleaning up... 09:08:13 INFO - Return code: 0 09:08:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:08:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:08:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:08:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:08:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:08:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7ee3afc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18cd6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197e900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c4b70>, '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 0x1a15dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a16250>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1448298236.934799-708591809', '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 09:08:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:08:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:08:13 INFO - Using env: {'DISPLAY': ':0', 09:08:13 INFO - 'HOME': '/home/cltbld', 09:08:13 INFO - 'LANG': 'en_US.UTF-8', 09:08:13 INFO - 'LANGUAGE': 'en_US:en', 09:08:13 INFO - 'LOGNAME': 'cltbld', 09:08:13 INFO - 'MAIL': '/var/mail/cltbld', 09:08:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:13 INFO - 'MOZ_NO_REMOTE': '1', 09:08:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:13 INFO - 'NO_EM_RESTART': '1', 09:08:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:08:13 INFO - 'PWD': '/builds/slave/test', 09:08:13 INFO - 'SHELL': '/bin/bash', 09:08:13 INFO - 'SHLVL': '1', 09:08:13 INFO - 'TERM': 'linux', 09:08:13 INFO - 'TMOUT': '86400', 09:08:13 INFO - 'USER': 'cltbld', 09:08:13 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1448298236.934799-708591809', 09:08:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:13 INFO - '_': '/tools/buildbot/bin/python'} 09:08:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:08:13 INFO - Running setup.py (path:/tmp/pip-hCJ7h2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:08:13 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:08:13 INFO - Running setup.py (path:/tmp/pip-4X7Wle-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:08: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)) 09:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:08:13 INFO - Running setup.py (path:/tmp/pip-gd30ST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:08: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)) 09:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:08:13 INFO - Running setup.py (path:/tmp/pip-IcfooW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:08: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)) 09:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:08:13 INFO - Running setup.py (path:/tmp/pip-StIQ0u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:08:14 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)) 09:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:08:14 INFO - Running setup.py (path:/tmp/pip-wm9SJU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:08:14 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)) 09:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:08:14 INFO - Running setup.py (path:/tmp/pip-7aGtwc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:08:14 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)) 09:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:08:14 INFO - Running setup.py (path:/tmp/pip-C_TAky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:08:14 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)) 09:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:08:14 INFO - Running setup.py (path:/tmp/pip-d1DZMF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:08:14 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)) 09:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:08:14 INFO - Running setup.py (path:/tmp/pip-BUXcaS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:08:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:08:14 INFO - Running setup.py (path:/tmp/pip-FTEqF6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:08:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:08:14 INFO - Running setup.py (path:/tmp/pip-fVqZ7A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:08:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:08:14 INFO - Running setup.py (path:/tmp/pip-dWPaxM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:08:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:08:14 INFO - Running setup.py (path:/tmp/pip-faFT8u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:08:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:08:14 INFO - Running setup.py (path:/tmp/pip-I0MGzC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:08: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)) 09:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:08:14 INFO - Running setup.py (path:/tmp/pip-zoaKOO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:08: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)) 09:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:08:14 INFO - Running setup.py (path:/tmp/pip-MjQqiR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:08: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)) 09:08: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)) 09:08: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)) 09:08: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)) 09:08: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)) 09:08: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)) 09:08:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:08: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 09:08: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 09:08: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 09:08: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 09:08: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 09:08: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 09:08:16 INFO - Downloading blessings-1.5.1.tar.gz 09:08:16 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 09:08:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:08:16 INFO - Installing collected packages: blessings 09:08:16 INFO - Running setup.py install for blessings 09:08:16 INFO - Successfully installed blessings 09:08:16 INFO - Cleaning up... 09:08:16 INFO - Return code: 0 09:08:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:08:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:08:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:08:17 INFO - Reading from file tmpfile_stdout 09:08:17 INFO - Current package versions: 09:08:17 INFO - argparse == 1.2.1 09:08:17 INFO - blessings == 1.5.1 09:08:17 INFO - blobuploader == 1.2.4 09:08:17 INFO - docopt == 0.6.1 09:08:17 INFO - manifestparser == 1.1 09:08:17 INFO - mozInstall == 1.12 09:08:17 INFO - mozcrash == 0.16 09:08:17 INFO - mozdebug == 0.1 09:08:17 INFO - mozdevice == 0.47 09:08:17 INFO - mozfile == 1.2 09:08:17 INFO - mozhttpd == 0.7 09:08:17 INFO - mozinfo == 0.9 09:08:17 INFO - mozleak == 0.1 09:08:17 INFO - mozlog == 3.1 09:08:17 INFO - moznetwork == 0.27 09:08:17 INFO - mozprocess == 0.22 09:08:17 INFO - mozprofile == 0.27 09:08:17 INFO - mozrunner == 6.11 09:08:17 INFO - mozscreenshot == 0.1 09:08:17 INFO - mozsystemmonitor == 0.0 09:08:17 INFO - moztest == 0.7 09:08:17 INFO - mozversion == 1.4 09:08:17 INFO - psutil == 3.1.1 09:08:17 INFO - requests == 1.2.3 09:08:17 INFO - wsgiref == 0.1.2 09:08:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:08:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:08:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:08:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:08:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:08:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 0x7ff7ee3afc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18cd6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197e900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c4b70>, '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 0x1a15dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a16250>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1448298236.934799-708591809', '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 09:08:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 09:08:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/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 09:08:17 INFO - Using env: {'DISPLAY': ':0', 09:08:17 INFO - 'HOME': '/home/cltbld', 09:08:17 INFO - 'LANG': 'en_US.UTF-8', 09:08:17 INFO - 'LANGUAGE': 'en_US:en', 09:08:17 INFO - 'LOGNAME': 'cltbld', 09:08:17 INFO - 'MAIL': '/var/mail/cltbld', 09:08:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:17 INFO - 'MOZ_NO_REMOTE': '1', 09:08:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:17 INFO - 'NO_EM_RESTART': '1', 09:08:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:08:17 INFO - 'PWD': '/builds/slave/test', 09:08:17 INFO - 'SHELL': '/bin/bash', 09:08:17 INFO - 'SHLVL': '1', 09:08:17 INFO - 'TERM': 'linux', 09:08:17 INFO - 'TMOUT': '86400', 09:08:17 INFO - 'USER': 'cltbld', 09:08:17 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1448298236.934799-708591809', 09:08:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:17 INFO - '_': '/tools/buildbot/bin/python'} 09:08:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:08:17 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)) 09:08:17 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)) 09:08:17 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)) 09:08:17 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)) 09:08:17 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)) 09:08:17 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)) 09:08:17 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)) 09:08:17 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)) 09:08:17 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)) 09:08:17 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)) 09:08:17 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)) 09:08:17 INFO - Cleaning up... 09:08:17 INFO - Return code: 0 09:08:17 INFO - Running post-action listener: _resource_record_post_action 09:08:17 INFO - Running post-action listener: _start_resource_monitoring 09:08:17 INFO - Starting resource monitoring. 09:08:17 INFO - ##### 09:08:17 INFO - ##### Running install step. 09:08:17 INFO - ##### 09:08:17 INFO - Running pre-action listener: _resource_record_pre_action 09:08:17 INFO - Running main action method: install 09:08:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:08:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:08:17 INFO - Reading from file tmpfile_stdout 09:08:17 INFO - Detecting whether we're running mozinstall >=1.0... 09:08:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:08:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:08:17 INFO - Reading from file tmpfile_stdout 09:08:17 INFO - Output received: 09:08:17 INFO - Usage: mozinstall [options] installer 09:08:17 INFO - Options: 09:08:17 INFO - -h, --help show this help message and exit 09:08:17 INFO - -d DEST, --destination=DEST 09:08:17 INFO - Directory to install application into. [default: 09:08:17 INFO - "/builds/slave/test"] 09:08:17 INFO - --app=APP Application being installed. [default: firefox] 09:08:17 INFO - mkdir: /builds/slave/test/build/application 09:08:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:08:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:08:31 INFO - Reading from file tmpfile_stdout 09:08:31 INFO - Output received: 09:08:31 INFO - /builds/slave/test/build/application/firefox/firefox 09:08:31 INFO - Running post-action listener: _resource_record_post_action 09:08:31 INFO - ##### 09:08:31 INFO - ##### Running run-tests step. 09:08:31 INFO - ##### 09:08:31 INFO - Running pre-action listener: _resource_record_pre_action 09:08:31 INFO - Running main action method: run_tests 09:08:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:08:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:08:31 INFO - Python 2.7.3 09:08:31 INFO - Return code: 0 09:08:31 INFO - grabbing minidump binary from tooltool 09:08:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:08:31 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c4b70>, '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 0x1a15dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a16250>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:08:31 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:08:31 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:08:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:08:32 INFO - Return code: 0 09:08:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:08:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:08:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:08:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:08:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:08:32 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/rgWqqQjYRByA4tSThUtIJA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost'] in /builds/slave/test/build 09:08:32 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/rgWqqQjYRByA4tSThUtIJA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --webServer localhost 09:08:32 INFO - Using env: {'DISPLAY': ':0', 09:08:32 INFO - 'HOME': '/home/cltbld', 09:08:32 INFO - 'LANG': 'en_US.UTF-8', 09:08:32 INFO - 'LANGUAGE': 'en_US:en', 09:08:32 INFO - 'LOGNAME': 'cltbld', 09:08:32 INFO - 'MAIL': '/var/mail/cltbld', 09:08:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:08:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:08:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:32 INFO - 'MOZ_NO_REMOTE': '1', 09:08:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:08:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:32 INFO - 'NO_EM_RESTART': '1', 09:08:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:08:32 INFO - 'PWD': '/builds/slave/test', 09:08:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:08:32 INFO - 'SHELL': '/bin/bash', 09:08:32 INFO - 'SHLVL': '1', 09:08:32 INFO - 'TERM': 'linux', 09:08:32 INFO - 'TMOUT': '86400', 09:08:32 INFO - 'USER': 'cltbld', 09:08:32 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1448298236.934799-708591809', 09:08:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:32 INFO - '_': '/tools/buildbot/bin/python'} 09:08:32 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/rgWqqQjYRByA4tSThUtIJA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost'] with output_timeout 3600 09:08:32 INFO - mozversion INFO | application_buildid: 20151123083130 09:08:32 INFO - mozversion INFO | application_changeset: 29f87d064607ef5683b5aec9eb7d0b732b101c08 09:08:32 INFO - mozversion INFO | application_display_name: Nightly 09:08:32 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:08:32 INFO - mozversion INFO | application_name: Firefox 09:08:32 INFO - mozversion INFO | application_remotingname: firefox 09:08:32 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 09:08:32 INFO - mozversion INFO | application_vendor: Mozilla 09:08:32 INFO - mozversion INFO | application_version: 45.0a1 09:08:32 INFO - mozversion INFO | platform_buildid: 20151123083130 09:08:32 INFO - mozversion INFO | platform_changeset: 29f87d064607ef5683b5aec9eb7d0b732b101c08 09:08:32 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 09:08:32 INFO - mozversion INFO | platform_version: 45.0a1 09:08:32 INFO - 2015-11-23 09:08:32,222 DEBUG : using testdate: 1448298512 09:08:32 INFO - 2015-11-23 09:08:32,222 DEBUG : actual date: 1448298512 09:08:32 INFO - 2015-11-23 09:08:32,232 INFO : starting webserver on 'localhost:39316' 09:08:32 INFO - 2015-11-23 09:08:32,233 INFO : Starting test suite talos-linux64-ix-001 09:08:32 INFO - 2015-11-23 09:08:32,233 INFO : Starting test dromaeo_css 09:08:32 INFO - 2015-11-23 09:08:32,233 DEBUG : operating with platform_type : linux_ 09:08:32 INFO - 2015-11-23 09:08:32,234 INFO : Initialising browser for dromaeo_css test... 09:08:32 INFO - 2015-11-23 09:08:32,250 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplfvFTe/profile http://localhost:39316/getInfo.html 09:08:36 INFO - 2015-11-23 09:08:36,920 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:08:36 INFO - 2015-11-23 09:08:36,921 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:08:36 INFO - 2015-11-23 09:08:36,921 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:08:36 INFO - 2015-11-23 09:08:36,921 DEBUG : BROWSER_OUTPUT: __metrics 09:08:37 INFO - 2015-11-23 09:08:37,098 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:08:38 INFO - 2015-11-23 09:08:38,368 INFO : Browser initialized. 09:08:38 INFO - 2015-11-23 09:08:38,369 INFO : Running cycle 1/1 for dromaeo_css test... 09:08:38 INFO - 2015-11-23 09:08:38,369 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplfvFTe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:08:50 INFO - 2015-11-23 09:08:50,372 DEBUG : BROWSER_OUTPUT: RSS: Main: 142561280 09:08:50 INFO - 2015-11-23 09:08:50,373 DEBUG : BROWSER_OUTPUT: 09:09:41 INFO - 2015-11-23 09:09:41,473 DEBUG : BROWSER_OUTPUT: 1448298581473 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] 09:11:53 INFO - 2015-11-23 09:11:53,456 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39316/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39316/tests/dromaeo/cssquery-ext.html) 09:11:54 INFO - 2015-11-23 09:11:54,601 DEBUG : BROWSER_OUTPUT: RSS: Main: 242987008 09:11:54 INFO - 2015-11-23 09:11:54,602 DEBUG : BROWSER_OUTPUT: 09:14:57 INFO - 2015-11-23 09:14:57,116 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39316/tests/dromaeo/cssquery-ext.html (next: http://localhost:39316/tests/dromaeo/cssquery-jquery.html) 09:14:57 INFO - 2015-11-23 09:14:57,697 DEBUG : BROWSER_OUTPUT: RSS: Main: 220524544 09:14:57 INFO - 2015-11-23 09:14:57,697 DEBUG : BROWSER_OUTPUT: 09:17:59 INFO - 2015-11-23 09:17:59,809 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39316/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39316/tests/dromaeo/cssquery-mootools.html) 09:18:00 INFO - 2015-11-23 09:18:00,396 DEBUG : BROWSER_OUTPUT: RSS: Main: 206987264 09:18:00 INFO - 2015-11-23 09:18:00,396 DEBUG : BROWSER_OUTPUT: 09:21:02 INFO - 2015-11-23 09:21:02,307 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39316/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39316/tests/dromaeo/cssquery-prototype.html) 09:21:02 INFO - 2015-11-23 09:21:02,881 DEBUG : BROWSER_OUTPUT: RSS: Main: 200413184 09:21:02 INFO - 2015-11-23 09:21:02,881 DEBUG : BROWSER_OUTPUT: 09:24:05 INFO - 2015-11-23 09:24:05,637 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39316/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39316/tests/dromaeo/cssquery-yui.html) 09:24:06 INFO - 2015-11-23 09:24:06,230 DEBUG : BROWSER_OUTPUT: RSS: Main: 207794176 09:24:06 INFO - 2015-11-23 09:24:06,231 DEBUG : BROWSER_OUTPUT: 09:27:08 INFO - 2015-11-23 09:27:08,933 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39316/tests/dromaeo/cssquery-yui.html (next: http://localhost:39316/tests/dromaeo/cssquery-dojo.html) 09:27:09 INFO - 2015-11-23 09:27:09,183 DEBUG : BROWSER_OUTPUT: RSS: Main: 274206720 09:27:09 INFO - 2015-11-23 09:27:09,183 DEBUG : BROWSER_OUTPUT: 09:27:09 INFO - 2015-11-23 09:27:09,185 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:27:09 INFO - 2015-11-23 09:27:09,185 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:27:09 INFO - 2015-11-23 09:27:09,185 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:27:09 INFO - 2015-11-23 09:27:09,185 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:27:09 INFO - 2015-11-23 09:27:09,186 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2592.779613732833;2678.7053424123355;2686.328417895525;2699.7840172786177;2708.5666293393056;4495.393121928539;4621.607163391116;4662.720236785795;4710.5524975127355;4717.528247175285;4560.8403705870305;4581.015081757421;4622.514635963226;4665.973485833119;4667.953320466794;4299.204647140274;4316.07204451043;4337.848175313865;4339.370791235269;4354.281543545327;4198.6850986176005;4369.73781573105;4383.430154079981;4424.247877860771;4438.090191510749;4231.576842315774;4234.894127646803;4275.038116423811;4321.178975994551;4333;4331;4351.6518678505645;4354.194474022284;4355.84754533593;4391.5827996340295;4331.350297455407;4335.046289816235;4340.370646256307;4372.562743725602;4387.363832244307;4380.7152535085115;4459.531749166324;4502.549745025504;4514.706544074625;4572.405587273666;4981.003799240167;5036.899262014776;5039.067772462106;5039.4708555601865;5087.771050302746;5039.697618142924;5057.2666963290485;5057.468965758616;5059.519345662156;5060.46865079165;4454.866354009385;4565.383673204141;4568.132054909556;4568.200564901163;4658.720476771405;5024.271480635288;5041.924371134436;5047.520485553867;5065.721385323843;5107.770150343169;4844.806207751651;4848.878778030577;4849.369581954394;4849.927251091236;4889.2910527973245;4723.929141062887;4853.708777473363;4857.635677324215;4893.828715994923;4980.252962055648;4881.145799485147;4915.066137433948;4918.262260660858;4924.212126059813;4966.329545511382;4879.121758083579;4884;4886.071646387175;4886.828960986349;4929.580985616191;4025.577314382006;4045.7167998239843;4137.1518838638;4143;4144.5026596808575;3608.8736894208578;3619.2399596084592;3639.47227651989;3641.945370819387;3656.6526180012856;4308.633766129851;4314.870553883388;4315.741055536678;4320.848770293024;4355.1942890564715;4788;4960.082384758831;4960.826371076995;4964.826231081895;4979.950200498021;4211.115665710236;4239.04621460169;4269.978650106729;4301.44081269433;4314.072474418015;4376.912461750747;4396.208682437192;4396.604305612446;4404.207242696345;4442.533533978885;4559.931601025921;4676.508966558463;4678.532146785295;4726.480087190406;4762.190427627312;4885.975570122127;4946.03552307311;4967.925481117858;4970.900581988268;5001.974990125026;4708.246680531099;4709.905801884011;4719.8348057819185;4730.858074257778;4753.453352864465;4710.952890471051;4806.399200099988;4808.927866082082;4884.9511504884495;4939.234418665113;4862.222044472867;4925.408950925912;4930.704157750546;4945.258211268195;4956;4845.442774080885;4871.707697538159;4875.19559272716;4883.487233840396;4917.213245880642;4627.120847039052;4738.739369334719;4866.440359358719;4872.6589138761365;4923.679960802537;4575.473820510684;4681.99337142516;4685.695429797052;4687.367205427224;4744.881377965578;4794.184988552024;4887.682300650446;4892.0705066037335;4898.21628539432;4938.16051271292;4503.347014682919;4670.159371313196;4796.25658023007;4801.423829140385;4815.422149342101 09:27:09 INFO - 2015-11-23 09:27:09,186 DEBUG : BROWSER_OUTPUT: |1;ext.html;559.3008739076155;561.7893290016243;572.3303734630482;572.6478215897224;583.2301362201895;27941.720582794165;28777.28056798581;37138.44292335617;38248;38283.42574861372;39927.20145597086;40335.39496907549;40339.79830100846;40404;40413.19173616526;6976.616286104262;7946.16565260648;8116;8118.350531957459;8124.471909325905;6962.338577835123;9867.16129129025;10090.545925433373;10092.495375231245;10094.949525252363;10074;10181.338213016168;10181.490925453734;10188.74528136795;10188.949055254714;7057.964710176468;7257.0565826442225;9950.950245248763;10040.799184016316;10140.492975351202;9973.35173213746;10132.54403551842;10138.543765530569;10144.340617859816;10150;36707.4493882592;37020.629793701984;37124.07189820249;37180;37206.81396593027;2537.4671319023028;2563.5898256279092;2613.297718597067;2646.5765477523696;2699.946001079987;28586.857065714747;28668.569971450444;28810.135695929155;28972.565411518844;28991.710082899324;3366.309906469168;3384.9830750846336;3397.1507123219194;3448.1724386147143;3480.286541259036;221628;221811;222456;222530;222667.99999999837;45765;46582.301265481045;54745;55063.44936550663;55211;62516.68741656263;63823;63825;64026;64031.35968640347;14025.78961315581;14204.786928196085;14210;14228.857711422961;14230.43078276878;10714.946425267824;10715.571377144826;10743.355398676105;10787.190960677824;10795.244332896622;18106.366277180234;18231.179596917904;18305.084745762924;18352.449426517225;18422.723659145122;7251.963740181371;7435.1821299656995;7453.478256521991;7454.589997550078;7485.288897554724;828.2173346187915;869.1004810021598;951.7382719752123;981.7005813227034;990.0841721407669;26310.73689263083;26588.601170982452;26606.467870642868;26767.598486022725;26897.86551067232;902.8420026495337;907.6460180529599;922.1746536849616;931.5063016601213;946.9289803264645;12713.364331783374;13295.867041329657;13304.13523120994;13344.132631378929;13862.861371386158;250047;251620;253532;254448;255094;46070;46571.30143047857;46579.5342046582;46642;46739.29891051637;1205.9095567832449;1213.6541085790507;1217.184486394118;1228.1464382254248;1237.7400745843474;21679.674804878254;24823.25530234096;26260.343491412867;28200.43599128047;29125.41749165047;40581.39127913024;40833;40917.18165636611;40927.59072409357;40953;220961;222022;222256;222321;222829;23818.285451436484;23990.640140398256;28681.28296792597;28963.85518072396;28976.971611987803;33601.15997100092;33672.49491257584;34092.65907340895;34288.31423371568;34501.65498345085;31776.841115794272;32052.35895282128;32228.83885580557;32649.836750816095;33336.666633333356;32108.839455803507;32219.838900805345;32229.51655725213;32287.35425291528;32343.676563235007;32358;32741.50887736638;32847.50728739023;32875.342493149525;32963.175920602174;27668;28196.872125115588;29353.41293174082;29467.85266073656;29569.704302957554;23206.76793232046;23289.417764556023;23597;23615.881920590287;23651.526969460858 09:27:09 INFO - 2015-11-23 09:27:09,188 DEBUG : BROWSER_OUTPUT: |2;jquery.html;317.16743548186014;334.3330056537209;336.0191670104732;336.3139196040078;337.99278151109695;12493.06302027347;12946.741065178714;14831;15446.459373921902;15698.37206511741;10022.649207277747;10124.066008710593;10270.281080324381;11858.110641701864;11950.462229199686;4263.360495925613;4366.8908277293;4381.43041404617;4386.429764130658;4386.561343865604;3283.5074738789135;3393.8303084845784;5154.098032844256;5279.9208011879855;5290.523852853243;5265;5279.70961597112;5281.788728450857;5298.761555730001;5315.096433606296;5268.394134674523;5666.5183459406;5667.659940403589;5668.0647693130995;5675;5036.647434679574;5041.571466425358;5044.268581055763;5052.595792336604;5057.190849464068;18956.24175032997;19092.61814763697;19539;19548.902255488774;19565.80434195654;1648.2418087679682;1690.9070001149933;1707.7523759054868;1759.041322479252;1841.6500864835639;9150.222231110363;9512.1439070484;10071.34536255141;10197.082262596328;12939.741205175938;1611.7743515907782;1627.698875707986;1682.5709444091801;1704.8977061376356;1763.4621440460655;53511.46488535104;54583;55085.724571377286;55536.722316388965;55760.442395575934;9658.420494770196;9706.320557561045;9710.126088651914;9712.611495540099;9755.268354873271;12494.625161244996;12495.312757798227;12516.99864010877;12519.624411267676;12527.87472125267;6481.740730370732;6579.8026059217345;6593.3736295051895;6698.765543205965;7021.5787052777;6095.6952152392205;6117.265928088658;6199.907001394983;6243.032329988859;6324.588901721466;4033.616806403387;4110.7328023678365;4213.620774130343;4216.620504154641;4298.656107511391;1613.693398254328;1657.9005259684457;1667.5414261078058;1674.6232097777902;1684.2336736784735;671.8454755406284;820.3027426687268;833.9332853371716;848.6647774129184;911.1435250864166;14808.259587020606;15326.23368831554;15507.147106909228;15952.441664541917;16087.597810054609;763.9083310002835;813.3940214540205;824.0934971531387;858.2104463893234;886.2821114896955;8252.133525979805;8516.190961858614;8636.265917397091;8664.09027052163;8736.213740763234;312195;314259;457478;457789;458065;66977.66511167413;69106.65446672835;70057.64971175214;70080.6495967517;70202;983.6213057972732;1008.5461542305992;1072.8712554493354;1092.9289596176222;1092.9617463388743;14416.567502974927;14428.927855361077;14472.638184045483;14812.334114753818;14927.402903884158;29939.251518712208;31178.22054448657;32148.678513214567;32672.50991235086;32805.34389312248;37305.25389492141;38534.80732596431;42987;43401.56598433975;44178.337324940796;8762.561871906506;9202.723918282461;9215.44707317563;9221.308401870021;9282.72151835446;10806.891931080589;10890.455477225949;14675.853241467876;16284;16610.66778664444;13635;13673.384697688429;14012.509562165274;14069.366878490287;14185.432582696576;13331.533396331082;13426;13505.662358441117;13695.794563081363;13704.177749335071;10978.780424391627;14047.652250134437;14093.506727264497;14199;14486.855131448972;7617.466777325534;7740.071191457061;8728.3890127693;8731.56342182901;8747.518886461306;9181.954090229507;12502.124851260689;12521.56174533887;12759.553415630407;13225.801612976005 09:27:09 INFO - 2015-11-23 09:27:09,189 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1333.9132956357842;1559.7894284271624;1623.2776414495547;1630.2012014113081;1659.5187395655269;6009.338972713003;6365.586236894598;6566.24488183859;6568.408843204111;6583.604983700981;6795.49033822464;6880.690368933398;6902.585844849313;6903.758368457105;6908.8272793180195;1641.1630068664947;1666.9166541672928;2021.9898900505477;2029.5433527456314;2052.5792212596457;2028.513156842362;2034.776174620798;2047.9897600512052;2053.3326668832688;2054.7020682001103;1968.9367741419617;1973.1022384814946;2029.8071683190074;2032.7357443532321;2035.0435295411132;1954.257382194771;1983.771866235387;1987.8906660133687;1990.2337600024023;2086.2176683743596;2059.794020597943;2085.655866781979;2086.1759604955955;2087.2485905074163;2088.3839267415997;6862.210845752703;6900.309969003059;6912.239653638096;6912.758053468155;6927;3955.9011024724614;3996.2407142643096;4005.339119045383;4014.036631208489;4021.577734337911;2318.431984163874;2548.719640839506;2662.7204143565036;2667.213172114231;2689.744474274941;840.8738689196608;857.4041041476177;861.8060936289347;883.730462209026;900.9864852027225;9020;9031.232345250595;9115.908840911572;9150.81698366029;9188.816223675556;3769.4157405602177;3801.8669346572738;3852.768833869977;3910.4720862683744;3911.041794760302;7982.720604778805;7983.880241796378;7991.520508769376;7998.4001199910235;8001.359891208689;3968.2261958917734;3971.3645816669195;3975.3241948868185;3977.3039718049226;3979.8010099495486;3587.192881601619;3597.6762091411897;3603.8017909015257;3607.314610224049;3608.2061946371755;3291.835408229579;3304.256542277968;3306.9338613228083;3331.1672081979505;3344.3812894614575;1026.4354604967239;1031.8142734307746;1069.7539565899888;1070.03162138265;1070.5075665194097;788.3141666749964;851.9648626918324;1153.5212886651946;1164.2374244869625;1169.3217933598492;6521.804345869631;6593.011048342691;6597.109390232353;6617.569857959217;6618.966905165444;952.4713783849892;1023.4319952426326;1035.409816404642;1040.6305761454726;1066.3761699405934;4983.750812459362;4999.700017998932;5040.924386134211;5061.544460998528;5062.190049592121;8028.678852845821;8160.918390816135;8257;8285.461445006054;8351.331893448509;8154.062282837431;8171.591420428955;8222.671093156207;8238.876416853753;8336.66653333872;6177.382261773877;6329.905051424233;6435.806925792233;6443.4523065539015;6463.159789227464;6524.641144737085;6592.538522303393;6620.900686489803;6622.668866556749;6624.503162262753;7411.258874112761;7440.62796860144;7442.96278518604;7533.3973282138395;7541.4343924207005;7528.284812942762;7636.389088872766;7709.190534993745;7736.1490236075115;7817.413693972861;5935.872184284972;6000.8499787503915;6008.309044459943;6016.217891674054;6020.518358531394;6277.905831412441;6278.874422511432;6559.836004099936;6570.934290657032;6599.9010014848855;6075.179850720273;6083.6349819011;6205.906911396242;6215.409536094064;6266.780662676784;5819;5832.708364581838;5883.823485295448;5899.144624029406;6050.485708714808;6213.844653883689;6226.50187984951;6244.5316601256;6266.874662506633;6270.2475702915945;5722.256106706268;5755.625884317506;5774.451427114417;5775.797847075332;5781.132830075522;5117.2835802986865;5696;5741.885162296647;5746.310442746897;5747.224124743107 09:27:09 INFO - 2015-11-23 09:27:09,189 DEBUG : BROWSER_OUTPUT: |4;prototype.html;308.9505679091345;315.575550884061;316.8811695614144;321.13294105914036;321.8632081365421;5245.213218017299;5308.70802105884;5383.676979381235;5393.622446428752;5396.109641909085;5167.870803229921;5297.258383826267;5311.814086506973;5320.680759154454;5329.227262047001;4206.41110244566;4207.347861081522;4210.2842516772225;4219.409282700424;4223.260929337369;3945.191235796655;4040.4545386372906;4079.2453396121664;4205.3481710334945;4223.13425747721;4178.958210417903;4181.770002649853;4182.53992060873;4194.161167766459;4211.68412369072;4180.707350485467;4182.121754431558;4202.474690663667;4203.432536607549;4204.642605378546;3709.684676802475;3714.758540694846;3716.684081853046;3718.2749363874054;3718.4050551911564;5021.096202683516;5131.4098878629065;5146.691198528063;5159.14874045782;5169.534741873212;4784.091022705675;4792.832250871203;4799.520047995207;4799.952000479985;4814.085323788469;5608.523275521586;5619.438056194389;5623.240862483553;5631.324241091095;5631.662100273997;3763.284975854579;3870.4968354113785;3873.8644147454984;4005.619466150711;4019.979900100481;5870;5896;5899;5900.55745819061;5903.291605007426;4141.544430112685;4142.399352093989;4144.150449157915;4144.611555129005;4147.875563733093;4201.45381100455;4216.768077755692;4223.113146239262;4224;4224.831006759757;4647.930281045787;4767.070421267819;4782.856514304576;4784.114938736345;4795.784189711471;5619.241402410704;5621.7751289948765;5622.297212848394;5624.325080990226;5624.465675760796;1468;1495.0207614012838;1497.445945000357;1497.445945000357;1497.8951473396976;1036.8081904847627;1040.7398150462384;1042.7028296935337;1054.2725519391595;1066.0512144191675;4932.136876046678;4953.479884612064;4955.801767929314;4955.851324460272;4965;5832.12518122285;5833.970830145907;5834.533237341003;5836.8540786479825;5837.686520532931;4946.901061978812;4954.677945933503;4957.157283261854;4961.925571116436;4963.875903102451;3075.7539396848647;3102.9224269393444;3119.984400077985;3140.6702296259023;3149.4803357445767;5455.236266922634;5486.670799752028;5505.862353441116;5517.089680202802;5525.171224316305;5940.495057920039;5949.672767997715;5955.28536575605;5959.821205363846;5964.075568286922;5479.2602998594675;5494.1758736189895;5494.846082322677;5495.642783219078;5517.586181036358;5643.463870932255;5818.854528636818;5819.534437244925;5823.475887170175;5824.922389357982;5461.890762184814;5623.297087864017;5624.465675760796;5676.375598684059;5685.431456854281;5409.540189083972;5518.3377994639295;5543.861403464945;5553.16702494629;5562.943040822231;4045.5752146024242;4048.2308361411237;4050.10897602527;4055.1281474483126;4059.3707975263883;5739.253896993364;5835.387284335254;5843.766249350148;5853.326867410132;5855.38518455556;5595.07681232592;5609.158626205938;5614.326280846324;5616.269884914935;5618.297712785902;5605.691686957093;5610.18652295423;5614.242077319673;5614.905093506727;5617.297837770278;5499.807506737245;5503.899220156065;5506.513241424873;5517.724113794375;5527.226188333717;5525.336959564717;5669.404712505293;5671.517920976598;5677.51741102011;5680.204771331934;5536.280283563272;5536.446355364431;5536.446355364593;5538.833834984957;5543.528800051879 09:27:09 INFO - 2015-11-23 09:27:09,190 DEBUG : BROWSER_OUTPUT: |5;yui.html;637.8947473666846;661.6790856434628;665.3047565294269;675.2369822101025;751.4476859508261;10347.327423717454;10596.364218146917;11019.118470522359;11026.062784663292;11028.338299702013;11307.717307067327;11415.086793056556;11426.028787553068;11431.714207144825;11440.771184576304;604.4469310580813;611.8103387949727;731.959742214178;738.3760722189741;745.0351794426203;746.8319628083692;747.4244831479757;752.5898385379953;753.8228516298666;754.3587950242305;630.5838146823098;786.0096278688865;786.3316181245953;793.3692714292151;793.6230290611942;633.189517417706;775.7401270574364;799.588212070784;800.3117319105564;800.4076983032514;571.434280062739;576.7894718427743;576.815419065899;576.8846230753866;577.5177726598296;10841.295315804447;10937.507812148473;10940.726481837939;10952.397618130999;10961.725956851064;10687.465626718711;10759.731006724895;11004.449777511172;11267.492962816694;11763.176577639482;8941.776455588597;8991;9050.954745226298;9149.908500915039;9179.541022948826;3214.4374734421617;3248.675132486756;3265;3267.15054085937;3267.248532837437;40569.1886162278;40780;41184.79407602973;41198.79400602978;41523.792381038205;8855.73432797017;8866.778330541789;8873.201411872962;8893.73318800437;8934.061923497939;17100.91449542744;17163;17167.484975450756;17173.484795456156;17287.65424691499;6294.685265736694;6326.082718005863;6463.256725476536;6485.740570377132;6501.447376972916;3428.6228514863346;3438.0717206354143;3445.8621655134016;3478.3217272631596;3496.423090190141;2710.715374885648;2727.495413348497;2742.4240909409245;2750;2750.546159883637;480.4042986696541;486.3992968683673;493.10009233149646;499.8425495968758;501.1030255842075;463.8496528609068;498.7157320327451;510.12037050847755;513.4249640402772;524.3498062402593;7011.89482157768;7212.639368031682;7942.126366099725;8271.2142346477;8605.354598405145;401.4921124777159;421.2396624093541;458.9036302376472;468.063872255489;540.7053156029973;3268.1829542614346;3280.676813568086;3364.327134573095;3422.1615704152146;3547.7161827053774;48964;49936.750316248916;50287.49712502901;50348.49651503438;50398.244026339635;45056.54943450589;45587.54412455899;46234.768826155654;46500;46870.765646172236;41449;41925.580744192775;41946.16107677829;42272.365914510694;42585.78707106445;6772.52592318533;7069.293070692889;7128.180259270251;7213.062301900719;7276.672549735169;33560;33874.83062584671;33922.66077339195;34303.31393372069;34631.82684086564;38625.80687096546;38758.4186237201;39268.60731392649;39357.409638854864;39471.407928881665;9292.814143717223;9372.531373431437;9384.718458446258;9455;9792.265580081379;10175.135113515138;10302.22733294991;10485.737856553647;10580.84128738085;11044;9505.192058674813;9798.167155791838;10198.694039178836;10204.591816327264;10275.691729248134;10324.328918620266;10336.896631033593;10491.160707143257;10582.365058096539;10677.252592318464;9009.81980360376;9443.669471568463;9630.181434577858;9717.951410242904;9744.317897747089;7920.960395197987;7927.603619819101;8064.55644939534;8263.83472330538;8341.749747507585;7786.922130778847;7846.725364612211;7855.764327070197;7986.92013079885;8203.179682031749 09:27:09 INFO - 2015-11-23 09:27:09,190 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:27:09 INFO - 2015-11-23 09:27:09,190 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:27:09 INFO - 2015-11-23 09:27:09,190 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,960 09:27:09 INFO - 2015-11-23 09:27:09,190 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:27:09 INFO - 2015-11-23 09:27:09,191 DEBUG : BROWSER_OUTPUT: __startTimestamp1448299629183__endTimestamp 09:27:09 INFO - 2015-11-23 09:27:09,191 DEBUG : BROWSER_OUTPUT: 09:27:09 INFO - 2015-11-23 09:27:09,191 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:27:09 INFO - 2015-11-23 09:27:09,191 DEBUG : BROWSER_OUTPUT: Number of tests: 6 09:27:09 INFO - 2015-11-23 09:27:09,191 DEBUG : BROWSER_OUTPUT: 09:27:09 INFO - 2015-11-23 09:27:09,191 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4578.06 Median:4687.37 stddev:466.43 (10.0%) stddev-sans-first:441.09 09:27:09 INFO - 2015-11-23 09:27:09,191 DEBUG : BROWSER_OUTPUT: Values: 2592.8 2678.7 2686.3 2699.8 2708.6 4495.4 4621.6 4662.7 4710.6 4717.5 4560.8 4581.0 4622.5 4666.0 4668.0 4299.2 4316.1 4337.8 4339.4 4354.3 4198.7 4369.7 4383.4 4424.2 4438.1 4231.6 4234.9 4275.0 4321.2 4333.0 4331.0 4351.7 4354.2 4355.8 4391.6 4331.4 4335.0 4340.4 4372.6 4387.4 4380.7 4459.5 4502.5 4514.7 4572.4 4981.0 5036.9 5039.1 5039.5 5087.8 5039.7 5057.3 5057.5 5059.5 5060.5 4454.9 4565.4 4568.1 4568.2 4658.7 5024.3 5041.9 5047.5 5065.7 5107.8 4844.8 4848.9 4849.4 4849.9 4889.3 4723.9 4853.7 4857.6 4893.8 4980.3 4881.1 4915.1 4918.3 4924.2 4966.3 4879.1 4884.0 4886.1 4886.8 4929.6 4025.6 4045.7 4137.2 4143.0 4144.5 3608.9 3619.2 3639.5 3641.9 3656.7 4308.6 4314.9 4315.7 4320.8 4355.2 4788.0 4960.1 4960.8 4964.8 4980.0 4211.1 4239.0 4270.0 4301.4 4314.1 4376.9 4396.2 4396.6 4404.2 4442.5 4559.9 4676.5 4678.5 4726.5 4762.2 4886.0 4946.0 4967.9 4970.9 5002.0 4708.2 4709.9 4719.8 4730.9 4753.5 4711.0 4806.4 4808.9 4885.0 4939.2 4862.2 4925.4 4930.7 4945.3 4956.0 4845.4 4871.7 4875.2 4883.5 4917.2 4627.1 4738.7 4866.4 4872.7 4923.7 4575.5 4682.0 4685.7 4687.4 4744.9 4794.2 4887.7 4892.1 4898.2 4938.2 4503.3 4670.2 4796.3 4801.4 4815.4 09:27:09 INFO - 2015-11-23 09:27:09,191 DEBUG : BROWSER_OUTPUT: 09:27:09 INFO - 2015-11-23 09:27:09,191 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39535.41 Median:30673.27 stddev:60525.63 (197.3%) stddev-sans-first:60624.66 09:27:09 INFO - 2015-11-23 09:27:09,192 DEBUG : BROWSER_OUTPUT: Values: 559.3 561.8 572.3 572.6 583.2 27941.7 28777.3 37138.4 38248.0 38283.4 39927.2 40335.4 40339.8 40404.0 40413.2 6976.6 7946.2 8116.0 8118.4 8124.5 6962.3 9867.2 10090.5 10092.5 10094.9 10074.0 10181.3 10181.5 10188.7 10188.9 7058.0 7257.1 9951.0 10040.8 10140.5 9973.4 10132.5 10138.5 10144.3 10150.0 36707.4 37020.6 37124.1 37180.0 37206.8 2537.5 2563.6 2613.3 2646.6 2699.9 28586.9 28668.6 28810.1 28972.6 28991.7 3366.3 3385.0 3397.2 3448.2 3480.3 221628.0 221811.0 222456.0 222530.0 222668.0 45765.0 46582.3 54745.0 55063.4 55211.0 62516.7 63823.0 63825.0 64026.0 64031.4 14025.8 14204.8 14210.0 14228.9 14230.4 10714.9 10715.6 10743.4 10787.2 10795.2 18106.4 18231.2 18305.1 18352.4 18422.7 7252.0 7435.2 7453.5 7454.6 7485.3 828.2 869.1 951.7 981.7 990.1 26310.7 26588.6 26606.5 26767.6 26897.9 902.8 907.6 922.2 931.5 946.9 12713.4 13295.9 13304.1 13344.1 13862.9 250047.0 251620.0 253532.0 254448.0 255094.0 46070.0 46571.3 46579.5 46642.0 46739.3 1205.9 1213.7 1217.2 1228.1 1237.7 21679.7 24823.3 26260.3 28200.4 29125.4 40581.4 40833.0 40917.2 40927.6 40953.0 220961.0 222022.0 222256.0 222321.0 222829.0 23818.3 23990.6 28681.3 28963.9 28977.0 33601.2 33672.5 34092.7 34288.3 34501.7 31776.8 32052.4 32228.8 32649.8 33336.7 32108.8 32219.8 32229.5 32287.4 32343.7 32358.0 32741.5 32847.5 32875.3 32963.2 27668.0 28196.9 29353.4 29467.9 29569.7 23206.8 23289.4 23597.0 23615.9 23651.5 09:27:09 INFO - 2015-11-23 09:27:09,193 DEBUG : BROWSER_OUTPUT: 09:27:09 INFO - 2015-11-23 09:27:09,193 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:23533.13 Median:37920.03 stddev:66531.14 (175.5%) stddev-sans-first:66694.94 09:27:09 INFO - 2015-11-23 09:27:09,193 DEBUG : BROWSER_OUTPUT: Values: 317.2 334.3 336.0 336.3 338.0 12493.1 12946.7 14831.0 15446.5 15698.4 10022.6 10124.1 10270.3 11858.1 11950.5 4263.4 4366.9 4381.4 4386.4 4386.6 3283.5 3393.8 5154.1 5279.9 5290.5 5265.0 5279.7 5281.8 5298.8 5315.1 5268.4 5666.5 5667.7 5668.1 5675.0 5036.6 5041.6 5044.3 5052.6 5057.2 18956.2 19092.6 19539.0 19548.9 19565.8 1648.2 1690.9 1707.8 1759.0 1841.7 9150.2 9512.1 10071.3 10197.1 12939.7 1611.8 1627.7 1682.6 1704.9 1763.5 53511.5 54583.0 55085.7 55536.7 55760.4 9658.4 9706.3 9710.1 9712.6 9755.3 12494.6 12495.3 12517.0 12519.6 12527.9 6481.7 6579.8 6593.4 6698.8 7021.6 6095.7 6117.3 6199.9 6243.0 6324.6 4033.6 4110.7 4213.6 4216.6 4298.7 1613.7 1657.9 1667.5 1674.6 1684.2 671.8 820.3 833.9 848.7 911.1 14808.3 15326.2 15507.1 15952.4 16087.6 763.9 813.4 824.1 858.2 886.3 8252.1 8516.2 8636.3 8664.1 8736.2 312195.0 314259.0 457478.0 457789.0 458065.0 66977.7 69106.7 70057.6 70080.6 70202.0 983.6 1008.5 1072.9 1092.9 1093.0 14416.6 14428.9 14472.6 14812.3 14927.4 29939.3 31178.2 32148.7 32672.5 32805.3 37305.3 38534.8 42987.0 43401.6 44178.3 8762.6 9202.7 9215.4 9221.3 9282.7 10806.9 10890.5 14675.9 16284.0 16610.7 13635.0 13673.4 14012.5 14069.4 14185.4 13331.5 13426.0 13505.7 13695.8 13704.2 10978.8 14047.7 14093.5 14199.0 14486.9 7617.5 7740.1 8728.4 8731.6 8747.5 9182.0 12502.1 12521.6 12759.6 13225.8 09:27:09 INFO - 2015-11-23 09:27:09,193 DEBUG : BROWSER_OUTPUT: 09:27:09 INFO - 2015-11-23 09:27:09,193 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4791.15 Median:5917.51 stddev:2464.99 (41.7%) stddev-sans-first:2458.21 09:27:09 INFO - 2015-11-23 09:27:09,193 DEBUG : BROWSER_OUTPUT: Values: 1333.9 1559.8 1623.3 1630.2 1659.5 6009.3 6365.6 6566.2 6568.4 6583.6 6795.5 6880.7 6902.6 6903.8 6908.8 1641.2 1666.9 2022.0 2029.5 2052.6 2028.5 2034.8 2048.0 2053.3 2054.7 1968.9 1973.1 2029.8 2032.7 2035.0 1954.3 1983.8 1987.9 1990.2 2086.2 2059.8 2085.7 2086.2 2087.2 2088.4 6862.2 6900.3 6912.2 6912.8 6927.0 3955.9 3996.2 4005.3 4014.0 4021.6 2318.4 2548.7 2662.7 2667.2 2689.7 840.9 857.4 861.8 883.7 901.0 9020.0 9031.2 9115.9 9150.8 9188.8 3769.4 3801.9 3852.8 3910.5 3911.0 7982.7 7983.9 7991.5 7998.4 8001.4 3968.2 3971.4 3975.3 3977.3 3979.8 3587.2 3597.7 3603.8 3607.3 3608.2 3291.8 3304.3 3306.9 3331.2 3344.4 1026.4 1031.8 1069.8 1070.0 1070.5 788.3 852.0 1153.5 1164.2 1169.3 6521.8 6593.0 6597.1 6617.6 6619.0 952.5 1023.4 1035.4 1040.6 1066.4 4983.8 4999.7 5040.9 5061.5 5062.2 8028.7 8160.9 8257.0 8285.5 8351.3 8154.1 8171.6 8222.7 8238.9 8336.7 6177.4 6329.9 6435.8 6443.5 6463.2 6524.6 6592.5 6620.9 6622.7 6624.5 7411.3 7440.6 7443.0 7533.4 7541.4 7528.3 7636.4 7709.2 7736.1 7817.4 5935.9 6000.8 6008.3 6016.2 6020.5 6277.9 6278.9 6559.8 6570.9 6599.9 6075.2 6083.6 6205.9 6215.4 6266.8 5819.0 5832.7 5883.8 5899.1 6050.5 6213.8 6226.5 6244.5 6266.9 6270.2 5722.3 5755.6 5774.5 5775.8 5781.1 5117.3 5696.0 5741.9 5746.3 5747.2 09:27:09 INFO - 2015-11-23 09:27:09,193 DEBUG : BROWSER_OUTPUT: 09:27:09 INFO - 2015-11-23 09:27:09,193 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4680.80 Median:5207.37 stddev:1350.28 (25.9%) stddev-sans-first:1313.59 09:27:09 INFO - 2015-11-23 09:27:09,194 DEBUG : BROWSER_OUTPUT: Values: 309.0 315.6 316.9 321.1 321.9 5245.2 5308.7 5383.7 5393.6 5396.1 5167.9 5297.3 5311.8 5320.7 5329.2 4206.4 4207.3 4210.3 4219.4 4223.3 3945.2 4040.5 4079.2 4205.3 4223.1 4179.0 4181.8 4182.5 4194.2 4211.7 4180.7 4182.1 4202.5 4203.4 4204.6 3709.7 3714.8 3716.7 3718.3 3718.4 5021.1 5131.4 5146.7 5159.1 5169.5 4784.1 4792.8 4799.5 4800.0 4814.1 5608.5 5619.4 5623.2 5631.3 5631.7 3763.3 3870.5 3873.9 4005.6 4020.0 5870.0 5896.0 5899.0 5900.6 5903.3 4141.5 4142.4 4144.2 4144.6 4147.9 4201.5 4216.8 4223.1 4224.0 4224.8 4647.9 4767.1 4782.9 4784.1 4795.8 5619.2 5621.8 5622.3 5624.3 5624.5 1468.0 1495.0 1497.4 1497.4 1497.9 1036.8 1040.7 1042.7 1054.3 1066.1 4932.1 4953.5 4955.8 4955.9 4965.0 5832.1 5834.0 5834.5 5836.9 5837.7 4946.9 4954.7 4957.2 4961.9 4963.9 3075.8 3102.9 3120.0 3140.7 3149.5 5455.2 5486.7 5505.9 5517.1 5525.2 5940.5 5949.7 5955.3 5959.8 5964.1 5479.3 5494.2 5494.8 5495.6 5517.6 5643.5 5818.9 5819.5 5823.5 5824.9 5461.9 5623.3 5624.5 5676.4 5685.4 5409.5 5518.3 5543.9 5553.2 5562.9 4045.6 4048.2 4050.1 4055.1 4059.4 5739.3 5835.4 5843.8 5853.3 5855.4 5595.1 5609.2 5614.3 5616.3 5618.3 5605.7 5610.2 5614.2 5614.9 5617.3 5499.8 5503.9 5506.5 5517.7 5527.2 5525.3 5669.4 5671.5 5677.5 5680.2 5536.3 5536.4 5536.4 5538.8 5543.5 09:27:09 INFO - 2015-11-23 09:27:09,195 DEBUG : BROWSER_OUTPUT: 09:27:09 INFO - 2015-11-23 09:27:09,195 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12151.16 Median:24728.55 stddev:14200.11 (57.4%) stddev-sans-first:14213.63 09:27:09 INFO - 2015-11-23 09:27:09,195 DEBUG : BROWSER_OUTPUT: Values: 637.9 661.7 665.3 675.2 751.4 10347.3 10596.4 11019.1 11026.1 11028.3 11307.7 11415.1 11426.0 11431.7 11440.8 604.4 611.8 732.0 738.4 745.0 746.8 747.4 752.6 753.8 754.4 630.6 786.0 786.3 793.4 793.6 633.2 775.7 799.6 800.3 800.4 571.4 576.8 576.8 576.9 577.5 10841.3 10937.5 10940.7 10952.4 10961.7 10687.5 10759.7 11004.4 11267.5 11763.2 8941.8 8991.0 9051.0 9149.9 9179.5 3214.4 3248.7 3265.0 3267.2 3267.2 40569.2 40780.0 41184.8 41198.8 41523.8 8855.7 8866.8 8873.2 8893.7 8934.1 17100.9 17163.0 17167.5 17173.5 17287.7 6294.7 6326.1 6463.3 6485.7 6501.4 3428.6 3438.1 3445.9 3478.3 3496.4 2710.7 2727.5 2742.4 2750.0 2750.5 480.4 486.4 493.1 499.8 501.1 463.8 498.7 510.1 513.4 524.3 7011.9 7212.6 7942.1 8271.2 8605.4 401.5 421.2 458.9 468.1 540.7 3268.2 3280.7 3364.3 3422.2 3547.7 48964.0 49936.8 50287.5 50348.5 50398.2 45056.5 45587.5 46234.8 46500.0 46870.8 41449.0 41925.6 41946.2 42272.4 42585.8 6772.5 7069.3 7128.2 7213.1 7276.7 33560.0 33874.8 33922.7 34303.3 34631.8 38625.8 38758.4 39268.6 39357.4 39471.4 9292.8 9372.5 9384.7 9455.0 9792.3 10175.1 10302.2 10485.7 10580.8 11044.0 9505.2 9798.2 10198.7 10204.6 10275.7 10324.3 10336.9 10491.2 10582.4 10677.3 9009.8 9443.7 9630.2 9718.0 9744.3 7921.0 7927.6 8064.6 8263.8 8341.7 7786.9 7846.7 7855.8 7986.9 8203.2 09:27:09 INFO - 2015-11-23 09:27:09,195 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:27:09 INFO - 2015-11-23 09:27:09,195 DEBUG : BROWSER_OUTPUT: 09:27:09 INFO - 2015-11-23 09:27:09,910 INFO : Browser exited with error code: 0 09:27:09 INFO - 2015-11-23 09:27:09,926 INFO : Completed test dromaeo_css (00:18:37) 09:27:09 INFO - 2015-11-23 09:27:09,926 INFO : Starting test kraken 09:27:09 INFO - 2015-11-23 09:27:09,926 DEBUG : operating with platform_type : linux_ 09:27:09 INFO - 2015-11-23 09:27:09,926 INFO : Initialising browser for kraken test... 09:27:09 INFO - 2015-11-23 09:27:09,932 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp63gf21/profile http://localhost:39316/getInfo.html 09:27:14 INFO - 2015-11-23 09:27:14,157 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:27:14 INFO - 2015-11-23 09:27:14,157 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:27:14 INFO - 2015-11-23 09:27:14,157 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:27:14 INFO - 2015-11-23 09:27:14,157 DEBUG : BROWSER_OUTPUT: __metrics 09:27:14 INFO - 2015-11-23 09:27:14,299 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:27:15 INFO - 2015-11-23 09:27:15,653 INFO : Browser initialized. 09:27:15 INFO - 2015-11-23 09:27:15,654 INFO : Running cycle 1/1 for kraken test... 09:27:15 INFO - 2015-11-23 09:27:15,654 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp63gf21/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:27:27 INFO - 2015-11-23 09:27:27,611 DEBUG : BROWSER_OUTPUT: RSS: Main: 140132352 09:27:27 INFO - 2015-11-23 09:27:27,611 DEBUG : BROWSER_OUTPUT: 09:27:30 INFO - 2015-11-23 09:27:30,228 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39316/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39316/tests/kraken/driver.html?testName=audio-beat-detection) 09:27:30 INFO - 2015-11-23 09:27:30,809 DEBUG : BROWSER_OUTPUT: RSS: Main: 178425856 09:27:30 INFO - 2015-11-23 09:27:30,809 DEBUG : BROWSER_OUTPUT: 09:27:33 INFO - 2015-11-23 09:27:33,511 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39316/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39316/tests/kraken/driver.html?testName=audio-dft) 09:27:34 INFO - 2015-11-23 09:27:34,094 DEBUG : BROWSER_OUTPUT: RSS: Main: 169586688 09:27:34 INFO - 2015-11-23 09:27:34,094 DEBUG : BROWSER_OUTPUT: 09:27:37 INFO - 2015-11-23 09:27:37,077 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39316/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39316/tests/kraken/driver.html?testName=audio-fft) 09:27:37 INFO - 2015-11-23 09:27:37,642 DEBUG : BROWSER_OUTPUT: RSS: Main: 152289280 09:27:37 INFO - 2015-11-23 09:27:37,643 DEBUG : BROWSER_OUTPUT: 09:27:39 INFO - 2015-11-23 09:27:39,680 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39316/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39316/tests/kraken/driver.html?testName=audio-oscillator) 09:27:40 INFO - 2015-11-23 09:27:40,252 DEBUG : BROWSER_OUTPUT: RSS: Main: 154931200 09:27:40 INFO - 2015-11-23 09:27:40,253 DEBUG : BROWSER_OUTPUT: 09:27:42 INFO - 2015-11-23 09:27:42,515 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39316/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39316/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:27:43 INFO - 2015-11-23 09:27:43,080 DEBUG : BROWSER_OUTPUT: RSS: Main: 154947584 09:27:43 INFO - 2015-11-23 09:27:43,080 DEBUG : BROWSER_OUTPUT: 09:27:46 INFO - 2015-11-23 09:27:46,039 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39316/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39316/tests/kraken/driver.html?testName=imaging-darkroom) 09:27:46 INFO - 2015-11-23 09:27:46,605 DEBUG : BROWSER_OUTPUT: RSS: Main: 155422720 09:27:46 INFO - 2015-11-23 09:27:46,605 DEBUG : BROWSER_OUTPUT: 09:27:50 INFO - 2015-11-23 09:27:50,060 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39316/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39316/tests/kraken/driver.html?testName=imaging-desaturate) 09:27:50 INFO - 2015-11-23 09:27:50,641 DEBUG : BROWSER_OUTPUT: RSS: Main: 157671424 09:27:50 INFO - 2015-11-23 09:27:50,641 DEBUG : BROWSER_OUTPUT: 09:27:53 INFO - 2015-11-23 09:27:53,484 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39316/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39316/tests/kraken/driver.html?testName=json-parse-financial) 09:27:54 INFO - 2015-11-23 09:27:54,065 DEBUG : BROWSER_OUTPUT: RSS: Main: 158187520 09:27:54 INFO - 2015-11-23 09:27:54,065 DEBUG : BROWSER_OUTPUT: 09:27:55 INFO - 2015-11-23 09:27:55,836 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39316/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39316/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:27:56 INFO - 2015-11-23 09:27:56,397 DEBUG : BROWSER_OUTPUT: RSS: Main: 167780352 09:27:56 INFO - 2015-11-23 09:27:56,398 DEBUG : BROWSER_OUTPUT: 09:27:58 INFO - 2015-11-23 09:27:58,273 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39316/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39316/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:27:58 INFO - 2015-11-23 09:27:58,867 DEBUG : BROWSER_OUTPUT: RSS: Main: 166383616 09:27:58 INFO - 2015-11-23 09:27:58,867 DEBUG : BROWSER_OUTPUT: 09:28:00 INFO - 2015-11-23 09:28:00,986 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39316/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39316/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:28:01 INFO - 2015-11-23 09:28:01,561 DEBUG : BROWSER_OUTPUT: RSS: Main: 173846528 09:28:01 INFO - 2015-11-23 09:28:01,561 DEBUG : BROWSER_OUTPUT: 09:28:04 INFO - 2015-11-23 09:28:04,104 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39316/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39316/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:28:04 INFO - 2015-11-23 09:28:04,689 DEBUG : BROWSER_OUTPUT: RSS: Main: 181338112 09:28:04 INFO - 2015-11-23 09:28:04,690 DEBUG : BROWSER_OUTPUT: 09:28:07 INFO - 2015-11-23 09:28:07,285 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39316/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39316/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:28:07 INFO - 2015-11-23 09:28:07,857 DEBUG : BROWSER_OUTPUT: RSS: Main: 178651136 09:28:07 INFO - 2015-11-23 09:28:07,857 DEBUG : BROWSER_OUTPUT: 09:28:09 INFO - 2015-11-23 09:28:09,611 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39316/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39316/tests/kraken/driver.html?testName=ai-astar) 09:28:09 INFO - 2015-11-23 09:28:09,861 DEBUG : BROWSER_OUTPUT: RSS: Main: 237436928 09:28:09 INFO - 2015-11-23 09:28:09,862 DEBUG : BROWSER_OUTPUT: 09:28:09 INFO - 2015-11-23 09:28:09,865 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:28:09 INFO - 2015-11-23 09:28:09,865 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:28:09 INFO - 2015-11-23 09:28:09,866 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:28:09 INFO - 2015-11-23 09:28:09,866 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:28:09 INFO - 2015-11-23 09:28:09,866 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;116;107;112;112;112;105;114;113;105 09:28:09 INFO - 2015-11-23 09:28:09,866 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;151;130;149;173;138;148;149;140;174;128 09:28:09 INFO - 2015-11-23 09:28:09,866 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;160;161;160;159;160;165;162;162;162 09:28:09 INFO - 2015-11-23 09:28:09,867 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;73;82;97;72;72;72;100;97;72 09:28:09 INFO - 2015-11-23 09:28:09,867 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;94;133;94;94;95;137;94;94;128 09:28:09 INFO - 2015-11-23 09:28:09,867 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;109;109;110;110;109;109;109;110 09:28:09 INFO - 2015-11-23 09:28:09,867 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;147;146;146;147;146;146;146;146;146 09:28:09 INFO - 2015-11-23 09:28:09,867 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 09:28:09 INFO - 2015-11-23 09:28:09,867 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;70;70;70;69;70;70;69;71;72;69 09:28:09 INFO - 2015-11-23 09:28:09,867 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;69;68;68;69;69;68;69;69 09:28:09 INFO - 2015-11-23 09:28:09,868 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;82;83;84;82;83;84;91;85;84 09:28:09 INFO - 2015-11-23 09:28:09,868 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;123;127;141;118;126;127;133;123;121;121 09:28:09 INFO - 2015-11-23 09:28:09,868 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;137;138;148;140;162;138;142;146;152;165 09:28:09 INFO - 2015-11-23 09:28:09,868 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;69;69;68;72;69;70;70;69;69 09:28:09 INFO - 2015-11-23 09:28:09,868 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:28:09 INFO - 2015-11-23 09:28:09,868 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:28:09 INFO - 2015-11-23 09:28:09,868 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,972 09:28:09 INFO - 2015-11-23 09:28:09,869 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:28:09 INFO - 2015-11-23 09:28:09,869 DEBUG : BROWSER_OUTPUT: __startTimestamp1448299689863__endTimestamp 09:28:09 INFO - 2015-11-23 09:28:09,869 DEBUG : BROWSER_OUTPUT: 09:28:09 INFO - 2015-11-23 09:28:09,872 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:28:09 INFO - 2015-11-23 09:28:09,872 DEBUG : BROWSER_OUTPUT: Number of tests: 14 09:28:09 INFO - 2015-11-23 09:28:09,872 DEBUG : BROWSER_OUTPUT: 09:28:09 INFO - 2015-11-23 09:28:09,872 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.90 Median:112.50 stddev:3.84 (3.4%) stddev-sans-first:4.00 09:28:09 INFO - 2015-11-23 09:28:09,872 DEBUG : BROWSER_OUTPUT: Values: 113.0 116.0 107.0 112.0 112.0 112.0 105.0 114.0 113.0 105.0 09:28:09 INFO - 2015-11-23 09:28:09,873 DEBUG : BROWSER_OUTPUT: 09:28:09 INFO - 2015-11-23 09:28:09,873 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.00 Median:149.00 stddev:15.63 (10.5%) stddev-sans-first:16.55 09:28:09 INFO - 2015-11-23 09:28:09,873 DEBUG : BROWSER_OUTPUT: Values: 151.0 130.0 149.0 173.0 138.0 148.0 149.0 140.0 174.0 128.0 09:28:09 INFO - 2015-11-23 09:28:09,873 DEBUG : BROWSER_OUTPUT: 09:28:09 INFO - 2015-11-23 09:28:09,873 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:1.69 (1.0%) stddev-sans-first:1.79 09:28:09 INFO - 2015-11-23 09:28:09,873 DEBUG : BROWSER_OUTPUT: Values: 161.0 160.0 161.0 160.0 159.0 160.0 165.0 162.0 162.0 162.0 09:28:09 INFO - 2015-11-23 09:28:09,873 DEBUG : BROWSER_OUTPUT: 09:28:09 INFO - 2015-11-23 09:28:09,873 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.90 Median:72.50 stddev:12.22 (16.8%) stddev-sans-first:12.52 09:28:09 INFO - 2015-11-23 09:28:09,873 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 82.0 97.0 72.0 72.0 72.0 100.0 97.0 72.0 09:28:09 INFO - 2015-11-23 09:28:09,873 DEBUG : BROWSER_OUTPUT: 09:28:09 INFO - 2015-11-23 09:28:09,873 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.80 Median:94.00 stddev:18.67 (19.9%) stddev-sans-first:19.38 09:28:09 INFO - 2015-11-23 09:28:09,873 DEBUG : BROWSER_OUTPUT: Values: 95.0 94.0 133.0 94.0 94.0 95.0 137.0 94.0 94.0 128.0 09:28:09 INFO - 2015-11-23 09:28:09,873 DEBUG : BROWSER_OUTPUT: 09:28:09 INFO - 2015-11-23 09:28:09,873 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 09:28:09 INFO - 2015-11-23 09:28:09,873 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 109.0 109.0 110.0 110.0 109.0 109.0 109.0 110.0 09:28:09 INFO - 2015-11-23 09:28:09,873 DEBUG : BROWSER_OUTPUT: 09:28:09 INFO - 2015-11-23 09:28:09,874 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 09:28:09 INFO - 2015-11-23 09:28:09,874 DEBUG : BROWSER_OUTPUT: Values: 146.0 147.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 146.0 09:28:09 INFO - 2015-11-23 09:28:09,874 DEBUG : BROWSER_OUTPUT: 09:28:09 INFO - 2015-11-23 09:28:09,874 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 09:28:09 INFO - 2015-11-23 09:28:09,874 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 09:28:09 INFO - 2015-11-23 09:28:09,874 DEBUG : BROWSER_OUTPUT: 09:28:09 INFO - 2015-11-23 09:28:09,874 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:70.00 Median:70.00 stddev:0.94 (1.3%) stddev-sans-first:1.00 09:28:09 INFO - 2015-11-23 09:28:09,874 DEBUG : BROWSER_OUTPUT: Values: 70.0 70.0 70.0 69.0 70.0 70.0 69.0 71.0 72.0 69.0 09:28:09 INFO - 2015-11-23 09:28:09,874 DEBUG : BROWSER_OUTPUT: 09:28:09 INFO - 2015-11-23 09:28:09,874 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:69.00 stddev:0.52 (0.7%) stddev-sans-first:0.50 09:28:09 INFO - 2015-11-23 09:28:09,874 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 69.0 68.0 68.0 69.0 69.0 68.0 69.0 69.0 09:28:09 INFO - 2015-11-23 09:28:09,874 DEBUG : BROWSER_OUTPUT: 09:28:09 INFO - 2015-11-23 09:28:09,875 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:84.00 stddev:2.67 (3.2%) stddev-sans-first:2.73 09:28:09 INFO - 2015-11-23 09:28:09,875 DEBUG : BROWSER_OUTPUT: Values: 82.0 82.0 83.0 84.0 82.0 83.0 84.0 91.0 85.0 84.0 09:28:09 INFO - 2015-11-23 09:28:09,875 DEBUG : BROWSER_OUTPUT: 09:28:09 INFO - 2015-11-23 09:28:09,875 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:126.00 Median:126.50 stddev:6.73 (5.3%) stddev-sans-first:7.05 09:28:09 INFO - 2015-11-23 09:28:09,875 DEBUG : BROWSER_OUTPUT: Values: 123.0 127.0 141.0 118.0 126.0 127.0 133.0 123.0 121.0 121.0 09:28:09 INFO - 2015-11-23 09:28:09,875 DEBUG : BROWSER_OUTPUT: 09:28:09 INFO - 2015-11-23 09:28:09,875 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.80 Median:147.00 stddev:10.06 (6.8%) stddev-sans-first:10.03 09:28:09 INFO - 2015-11-23 09:28:09,875 DEBUG : BROWSER_OUTPUT: Values: 137.0 138.0 148.0 140.0 162.0 138.0 142.0 146.0 152.0 165.0 09:28:09 INFO - 2015-11-23 09:28:09,875 DEBUG : BROWSER_OUTPUT: 09:28:09 INFO - 2015-11-23 09:28:09,875 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.50 Median:69.50 stddev:1.08 (1.6%) stddev-sans-first:1.13 09:28:09 INFO - 2015-11-23 09:28:09,875 DEBUG : BROWSER_OUTPUT: Values: 70.0 69.0 69.0 68.0 72.0 69.0 70.0 70.0 69.0 69.0 09:28:09 INFO - 2015-11-23 09:28:09,875 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:28:09 INFO - 2015-11-23 09:28:09,876 DEBUG : BROWSER_OUTPUT: 09:28:10 INFO - 2015-11-23 09:28:10,785 INFO : Browser exited with error code: 0 09:28:10 INFO - 2015-11-23 09:28:10,834 INFO : Completed test kraken (00:01:00) 09:28:10 INFO - 2015-11-23 09:28:10,834 INFO : Starting test v8_7 09:28:10 INFO - 2015-11-23 09:28:10,834 DEBUG : operating with platform_type : linux_ 09:28:10 INFO - 2015-11-23 09:28:10,834 INFO : Initialising browser for v8_7 test... 09:28:10 INFO - 2015-11-23 09:28:10,840 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNNQ2dQ/profile http://localhost:39316/getInfo.html 09:28:15 INFO - 2015-11-23 09:28:15,028 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:28:15 INFO - 2015-11-23 09:28:15,028 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:28:15 INFO - 2015-11-23 09:28:15,028 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:28:15 INFO - 2015-11-23 09:28:15,028 DEBUG : BROWSER_OUTPUT: __metrics 09:28:15 INFO - 2015-11-23 09:28:15,190 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:28:16 INFO - 2015-11-23 09:28:16,510 INFO : Browser initialized. 09:28:16 INFO - 2015-11-23 09:28:16,511 INFO : Running cycle 1/1 for v8_7 test... 09:28:16 INFO - 2015-11-23 09:28:16,511 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNNQ2dQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:28:28 INFO - 2015-11-23 09:28:28,401 DEBUG : BROWSER_OUTPUT: RSS: Main: 142897152 09:28:28 INFO - 2015-11-23 09:28:28,401 DEBUG : BROWSER_OUTPUT: 09:28:49 INFO - 2015-11-23 09:28:49,780 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39316/tests/v8_7/run.html (next: http://localhost:39316/tests/v8_7/run.html) 09:28:50 INFO - 2015-11-23 09:28:50,038 DEBUG : BROWSER_OUTPUT: RSS: Main: 443596800 09:28:50 INFO - 2015-11-23 09:28:50,038 DEBUG : BROWSER_OUTPUT: 09:28:50 INFO - 2015-11-23 09:28:50,038 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:28:50 INFO - 2015-11-23 09:28:50,038 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:28:50 INFO - 2015-11-23 09:28:50,039 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:28:50 INFO - 2015-11-23 09:28:50,039 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:28:50 INFO - 2015-11-23 09:28:50,039 DEBUG : BROWSER_OUTPUT: |0;Richards;190.91256204658268 09:28:50 INFO - 2015-11-23 09:28:50,039 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.64430816404752 09:28:50 INFO - 2015-11-23 09:28:50,039 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.01785714285717 09:28:50 INFO - 2015-11-23 09:28:50,039 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5000 09:28:50 INFO - 2015-11-23 09:28:50,039 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1955.078125 09:28:50 INFO - 2015-11-23 09:28:50,039 DEBUG : BROWSER_OUTPUT: |5;Earley;787.4015748031496 09:28:50 INFO - 2015-11-23 09:28:50,040 DEBUG : BROWSER_OUTPUT: |6;Boyer;12048.192771084337 09:28:50 INFO - 2015-11-23 09:28:50,040 DEBUG : BROWSER_OUTPUT: |7;RegExp;26710.526315789473 09:28:50 INFO - 2015-11-23 09:28:50,040 DEBUG : BROWSER_OUTPUT: |8;Splay;616.9031462060457 09:28:50 INFO - 2015-11-23 09:28:50,040 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 09:28:50 INFO - 2015-11-23 09:28:50,040 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:28:50 INFO - 2015-11-23 09:28:50,040 DEBUG : BROWSER_OUTPUT: __startTimestamp1448299730031__endTimestamp 09:28:50 INFO - 2015-11-23 09:28:50,040 DEBUG : BROWSER_OUTPUT: 09:28:50 INFO - 2015-11-23 09:28:50,041 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:28:50 INFO - 2015-11-23 09:28:50,041 DEBUG : BROWSER_OUTPUT: Number of tests: 10 09:28:50 INFO - 2015-11-23 09:28:50,041 DEBUG : BROWSER_OUTPUT: 09:28:50 INFO - 2015-11-23 09:28:50,041 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:190.91 Median:190.91 stddev:0.00 (0.0%) 09:28:50 INFO - 2015-11-23 09:28:50,041 DEBUG : BROWSER_OUTPUT: Values: 190.9 09:28:50 INFO - 2015-11-23 09:28:50,041 DEBUG : BROWSER_OUTPUT: 09:28:50 INFO - 2015-11-23 09:28:50,041 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.64 Median:191.64 stddev:0.00 (0.0%) 09:28:50 INFO - 2015-11-23 09:28:50,042 DEBUG : BROWSER_OUTPUT: Values: 191.6 09:28:50 INFO - 2015-11-23 09:28:50,042 DEBUG : BROWSER_OUTPUT: 09:28:50 INFO - 2015-11-23 09:28:50,042 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.02 Median:279.02 stddev:0.00 (0.0%) 09:28:50 INFO - 2015-11-23 09:28:50,042 DEBUG : BROWSER_OUTPUT: Values: 279.0 09:28:50 INFO - 2015-11-23 09:28:50,042 DEBUG : BROWSER_OUTPUT: 09:28:50 INFO - 2015-11-23 09:28:50,042 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5000.00 Median:5000.00 stddev:0.00 (0.0%) 09:28:50 INFO - 2015-11-23 09:28:50,042 DEBUG : BROWSER_OUTPUT: Values: 5000.0 09:28:50 INFO - 2015-11-23 09:28:50,042 DEBUG : BROWSER_OUTPUT: 09:28:50 INFO - 2015-11-23 09:28:50,043 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1955.08 Median:1955.08 stddev:0.00 (0.0%) 09:28:50 INFO - 2015-11-23 09:28:50,043 DEBUG : BROWSER_OUTPUT: Values: 1955.1 09:28:50 INFO - 2015-11-23 09:28:50,043 DEBUG : BROWSER_OUTPUT: 09:28:50 INFO - 2015-11-23 09:28:50,043 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:787.40 Median:787.40 stddev:0.00 (0.0%) 09:28:50 INFO - 2015-11-23 09:28:50,043 DEBUG : BROWSER_OUTPUT: Values: 787.4 09:28:50 INFO - 2015-11-23 09:28:50,043 DEBUG : BROWSER_OUTPUT: 09:28:50 INFO - 2015-11-23 09:28:50,043 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12048.19 Median:12048.19 stddev:0.00 (0.0%) 09:28:50 INFO - 2015-11-23 09:28:50,044 DEBUG : BROWSER_OUTPUT: Values: 12048.2 09:28:50 INFO - 2015-11-23 09:28:50,044 DEBUG : BROWSER_OUTPUT: 09:28:50 INFO - 2015-11-23 09:28:50,044 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26710.53 Median:26710.53 stddev:0.00 (0.0%) 09:28:50 INFO - 2015-11-23 09:28:50,044 DEBUG : BROWSER_OUTPUT: Values: 26710.5 09:28:50 INFO - 2015-11-23 09:28:50,044 DEBUG : BROWSER_OUTPUT: 09:28:50 INFO - 2015-11-23 09:28:50,044 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:616.90 Median:616.90 stddev:0.00 (0.0%) 09:28:50 INFO - 2015-11-23 09:28:50,044 DEBUG : BROWSER_OUTPUT: Values: 616.9 09:28:50 INFO - 2015-11-23 09:28:50,044 DEBUG : BROWSER_OUTPUT: 09:28:50 INFO - 2015-11-23 09:28:50,045 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 09:28:50 INFO - 2015-11-23 09:28:50,045 DEBUG : BROWSER_OUTPUT: Values: 4826.9 09:28:50 INFO - 2015-11-23 09:28:50,045 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:28:50 INFO - 2015-11-23 09:28:50,045 DEBUG : BROWSER_OUTPUT: 09:28:50 INFO - 2015-11-23 09:28:50,977 INFO : Browser exited with error code: 0 09:28:50 INFO - 2015-11-23 09:28:50,994 INFO : Completed test v8_7 (00:00:40) 09:28:51 INFO - 2015-11-23 09:28:51,090 INFO : Completed test suite (00:20:18) 09:28:51 INFO - 2015-11-23 09:28:51,090 DEBUG : Working with test: dromaeo_css 09:28:51 INFO - 2015-11-23 09:28:51,090 DEBUG : Generating results file: dromaeo_css 09:28:51 INFO - 2015-11-23 09:28:51,091 DEBUG : Working with test: kraken 09:28:51 INFO - 2015-11-23 09:28:51,091 DEBUG : Generating results file: kraken 09:28:51 INFO - 2015-11-23 09:28:51,091 INFO : javascript benchmark 09:28:51 INFO - 2015-11-23 09:28:51,092 DEBUG : Working with test: v8_7 09:28:51 INFO - 2015-11-23 09:28:51,092 DEBUG : Generating results file: v8_7 09:28:51 INFO - 2015-11-23 09:28:51,092 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:28:51 INFO - 2015-11-23 09:28:51,157 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 09:28:51 INFO - 2015-11-23 09:28:51,157 DEBUG : process_Request line: dromaeo_css 6190.13 graph.html#tests=[[72,132,35]] 09:28:51 INFO - 2015-11-23 09:28:51,157 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:28:51 INFO - 2015-11-23 09:28:51,192 DEBUG : process_Request line: kraken 1522.30 graph.html#tests=[[232,132,35]] 09:28:51 INFO - 2015-11-23 09:28:51,192 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:28:51 INFO - 2015-11-23 09:28:51,224 DEBUG : process_Request line: v8_7 19575.84 graph.html#tests=[[230,132,35]] 09:28:51 INFO - 2015-11-23 09:28:51,226 INFO : javascript benchmark 09:28:51 INFO - 2015-11-23 09:28:51,229 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2592.779613732833, 2678.7053424123355, 2686.328417895525, 2699.7840172786177, 2708.5666293393056, 4495.393121928539, 4621.607163391116, 4662.720236785795, 4710.5524975127355, 4717.528247175285, 4560.8403705870305, 4581.015081757421, 4622.514635963226, 4665.973485833119, 4667.953320466794, 4299.204647140274, 4316.07204451043, 4337.848175313865, 4339.370791235269, 4354.281543545327, 4198.6850986176005, 4369.73781573105, 4383.430154079981, 4424.247877860771, 4438.090191510749, 4231.576842315774, 4234.894127646803, 4275.038116423811, 4321.178975994551, 4333.0, 4331.0, 4351.6518678505645, 4354.194474022284, 4355.84754533593, 4391.5827996340295, 4331.350297455407, 4335.046289816235, 4340.370646256307, 4372.562743725602, 4387.363832244307, 4380.7152535085115, 4459.531749166324, 4502.549745025504, 4514.706544074625, 4572.405587273666, 4981.003799240167, 5036.899262014776, 5039.067772462106, 5039.4708555601865, 5087.771050302746, 5039.697618142924, 5057.2666963290485, 5057.468965758616, 5059.519345662156, 5060.46865079165, 4454.866354009385, 4565.383673204141, 4568.132054909556, 4568.200564901163, 4658.720476771405, 5024.271480635288, 5041.924371134436, 5047.520485553867, 5065.721385323843, 5107.770150343169, 4844.806207751651, 4848.878778030577, 4849.369581954394, 4849.927251091236, 4889.2910527973245, 4723.929141062887, 4853.708777473363, 4857.635677324215, 4893.828715994923, 4980.252962055648, 4881.145799485147, 4915.066137433948, 4918.262260660858, 4924.212126059813, 4966.329545511382, 4879.121758083579, 4884.0, 4886.071646387175, 4886.828960986349, 4929.580985616191, 4025.577314382006, 4045.7167998239843, 4137.1518838638, 4143.0, 4144.5026596808575, 3608.8736894208578, 3619.2399596084592, 3639.47227651989, 3641.945370819387, 3656.6526180012856, 4308.633766129851, 4314.870553883388, 4315.741055536678, 4320.848770293024, 4355.1942890564715, 4788.0, 4960.082384758831, 4960.826371076995, 4964.826231081895, 4979.950200498021, 4211.115665710236, 4239.04621460169, 4269.978650106729, 4301.44081269433, 4314.072474418015, 4376.912461750747, 4396.208682437192, 4396.604305612446, 4404.207242696345, 4442.533533978885, 4559.931601025921, 4676.508966558463, 4678.532146785295, 4726.480087190406, 4762.190427627312, 4885.975570122127, 4946.03552307311, 4967.925481117858, 4970.900581988268, 5001.974990125026, 4708.246680531099, 4709.905801884011, 4719.8348057819185, 4730.858074257778, 4753.453352864465, 4710.952890471051, 4806.399200099988, 4808.927866082082, 4884.9511504884495, 4939.234418665113, 4862.222044472867, 4925.408950925912, 4930.704157750546, 4945.258211268195, 4956.0, 4845.442774080885, 4871.707697538159, 4875.19559272716, 4883.487233840396, 4917.213245880642, 4627.120847039052, 4738.739369334719, 4866.440359358719, 4872.6589138761365, 4923.679960802537, 4575.473820510684, 4681.99337142516, 4685.695429797052, 4687.367205427224, 4744.881377965578, 4794.184988552024, 4887.682300650446, 4892.0705066037335, 4898.21628539432, 4938.16051271292, 4503.347014682919, 4670.159371313196, 4796.25658023007, 4801.423829140385, 4815.422149342101], "unit": "ms", "name": "dojo.html", "value": 4549.640917198963}, {"lowerIsBetter": false, "replicates": [559.3008739076155, 561.7893290016243, 572.3303734630482, 572.6478215897224, 583.2301362201895, 27941.720582794165, 28777.28056798581, 37138.44292335617, 38248.0, 38283.42574861372, 39927.20145597086, 40335.39496907549, 40339.79830100846, 40404.0, 40413.19173616526, 6976.616286104262, 7946.16565260648, 8116.0, 8118.350531957459, 8124.471909325905, 6962.338577835123, 9867.16129129025, 10090.545925433373, 10092.495375231245, 10094.949525252363, 10074.0, 10181.338213016168, 10181.490925453734, 10188.74528136795, 10188.949055254714, 7057.964710176468, 7257.0565826442225, 9950.950245248763, 10040.799184016316, 10140.492975351202, 9973.35173213746, 10132.54403551842, 10138.543765530569, 10144.340617859816, 10150.0, 36707.4493882592, 37020.629793701984, 37124.07189820249, 37180.0, 37206.81396593027, 2537.4671319023028, 2563.5898256279092, 2613.297718597067, 2646.5765477523696, 2699.946001079987, 28586.857065714747, 28668.569971450444, 28810.135695929155, 28972.565411518844, 28991.710082899324, 3366.309906469168, 3384.9830750846336, 3397.1507123219194, 3448.1724386147143, 3480.286541259036, 221628.0, 221811.0, 222456.0, 222530.0, 222667.99999999837, 45765.0, 46582.301265481045, 54745.0, 55063.44936550663, 55211.0, 62516.68741656263, 63823.0, 63825.0, 64026.0, 64031.35968640347, 14025.78961315581, 14204.786928196085, 14210.0, 14228.857711422961, 14230.43078276878, 10714.946425267824, 10715.571377144826, 10743.355398676105, 10787.190960677824, 10795.244332896622, 18106.366277180234, 18231.179596917904, 18305.084745762924, 18352.449426517225, 18422.723659145122, 7251.963740181371, 7435.1821299656995, 7453.478256521991, 7454.589997550078, 7485.288897554724, 828.2173346187915, 869.1004810021598, 951.7382719752123, 981.7005813227034, 990.0841721407669, 26310.73689263083, 26588.601170982452, 26606.467870642868, 26767.598486022725, 26897.86551067232, 902.8420026495337, 907.6460180529599, 922.1746536849616, 931.5063016601213, 946.9289803264645, 12713.364331783374, 13295.867041329657, 13304.13523120994, 13344.132631378929, 13862.861371386158, 250047.0, 251620.0, 253532.0, 254448.0, 255094.0, 46070.0, 46571.30143047857, 46579.5342046582, 46642.0, 46739.29891051637, 1205.9095567832449, 1213.6541085790507, 1217.184486394118, 1228.1464382254248, 1237.7400745843474, 21679.674804878254, 24823.25530234096, 26260.343491412867, 28200.43599128047, 29125.41749165047, 40581.39127913024, 40833.0, 40917.18165636611, 40927.59072409357, 40953.0, 220961.0, 222022.0, 222256.0, 222321.0, 222829.0, 23818.285451436484, 23990.640140398256, 28681.28296792597, 28963.85518072396, 28976.971611987803, 33601.15997100092, 33672.49491257584, 34092.65907340895, 34288.31423371568, 34501.65498345085, 31776.841115794272, 32052.35895282128, 32228.83885580557, 32649.836750816095, 33336.666633333356, 32108.839455803507, 32219.838900805345, 32229.51655725213, 32287.35425291528, 32343.676563235007, 32358.0, 32741.50887736638, 32847.50728739023, 32875.342493149525, 32963.175920602174, 27668.0, 28196.872125115588, 29353.41293174082, 29467.85266073656, 29569.704302957554, 23206.76793232046, 23289.417764556023, 23597.0, 23615.881920590287, 23651.526969460858], "unit": "ms", "name": "ext.html", "value": 16915.326155124127}, {"lowerIsBetter": false, "replicates": [317.16743548186014, 334.3330056537209, 336.0191670104732, 336.3139196040078, 337.99278151109695, 12493.06302027347, 12946.741065178714, 14831.0, 15446.459373921902, 15698.37206511741, 10022.649207277747, 10124.066008710593, 10270.281080324381, 11858.110641701864, 11950.462229199686, 4263.360495925613, 4366.8908277293, 4381.43041404617, 4386.429764130658, 4386.561343865604, 3283.5074738789135, 3393.8303084845784, 5154.098032844256, 5279.9208011879855, 5290.523852853243, 5265.0, 5279.70961597112, 5281.788728450857, 5298.761555730001, 5315.096433606296, 5268.394134674523, 5666.5183459406, 5667.659940403589, 5668.0647693130995, 5675.0, 5036.647434679574, 5041.571466425358, 5044.268581055763, 5052.595792336604, 5057.190849464068, 18956.24175032997, 19092.61814763697, 19539.0, 19548.902255488774, 19565.80434195654, 1648.2418087679682, 1690.9070001149933, 1707.7523759054868, 1759.041322479252, 1841.6500864835639, 9150.222231110363, 9512.1439070484, 10071.34536255141, 10197.082262596328, 12939.741205175938, 1611.7743515907782, 1627.698875707986, 1682.5709444091801, 1704.8977061376356, 1763.4621440460655, 53511.46488535104, 54583.0, 55085.724571377286, 55536.722316388965, 55760.442395575934, 9658.420494770196, 9706.320557561045, 9710.126088651914, 9712.611495540099, 9755.268354873271, 12494.625161244996, 12495.312757798227, 12516.99864010877, 12519.624411267676, 12527.87472125267, 6481.740730370732, 6579.8026059217345, 6593.3736295051895, 6698.765543205965, 7021.5787052777, 6095.6952152392205, 6117.265928088658, 6199.907001394983, 6243.032329988859, 6324.588901721466, 4033.616806403387, 4110.7328023678365, 4213.620774130343, 4216.620504154641, 4298.656107511391, 1613.693398254328, 1657.9005259684457, 1667.5414261078058, 1674.6232097777902, 1684.2336736784735, 671.8454755406284, 820.3027426687268, 833.9332853371716, 848.6647774129184, 911.1435250864166, 14808.259587020606, 15326.23368831554, 15507.147106909228, 15952.441664541917, 16087.597810054609, 763.9083310002835, 813.3940214540205, 824.0934971531387, 858.2104463893234, 886.2821114896955, 8252.133525979805, 8516.190961858614, 8636.265917397091, 8664.09027052163, 8736.213740763234, 312195.0, 314259.0, 457478.0, 457789.0, 458065.0, 66977.66511167413, 69106.65446672835, 70057.64971175214, 70080.6495967517, 70202.0, 983.6213057972732, 1008.5461542305992, 1072.8712554493354, 1092.9289596176222, 1092.9617463388743, 14416.567502974927, 14428.927855361077, 14472.638184045483, 14812.334114753818, 14927.402903884158, 29939.251518712208, 31178.22054448657, 32148.678513214567, 32672.50991235086, 32805.34389312248, 37305.25389492141, 38534.80732596431, 42987.0, 43401.56598433975, 44178.337324940796, 8762.561871906506, 9202.723918282461, 9215.44707317563, 9221.308401870021, 9282.72151835446, 10806.891931080589, 10890.455477225949, 14675.853241467876, 16284.0, 16610.66778664444, 13635.0, 13673.384697688429, 14012.509562165274, 14069.366878490287, 14185.432582696576, 13331.533396331082, 13426.0, 13505.662358441117, 13695.794563081363, 13704.177749335071, 10978.780424391627, 14047.652250134437, 14093.506727264497, 14199.0, 14486.855131448972, 7617.466777325534, 7740.071191457061, 8728.3890127693, 8731.56342182901, 8747.518886461306, 9181.954090229507, 12502.124851260689, 12521.56174533887, 12759.553415630407, 13225.801612976005], "unit": "ms", "name": "jquery.html", "value": 7961.490235229549}, {"lowerIsBetter": false, "replicates": [1333.9132956357842, 1559.7894284271624, 1623.2776414495547, 1630.2012014113081, 1659.5187395655269, 6009.338972713003, 6365.586236894598, 6566.24488183859, 6568.408843204111, 6583.604983700981, 6795.49033822464, 6880.690368933398, 6902.585844849313, 6903.758368457105, 6908.8272793180195, 1641.1630068664947, 1666.9166541672928, 2021.9898900505477, 2029.5433527456314, 2052.5792212596457, 2028.513156842362, 2034.776174620798, 2047.9897600512052, 2053.3326668832688, 2054.7020682001103, 1968.9367741419617, 1973.1022384814946, 2029.8071683190074, 2032.7357443532321, 2035.0435295411132, 1954.257382194771, 1983.771866235387, 1987.8906660133687, 1990.2337600024023, 2086.2176683743596, 2059.794020597943, 2085.655866781979, 2086.1759604955955, 2087.2485905074163, 2088.3839267415997, 6862.210845752703, 6900.309969003059, 6912.239653638096, 6912.758053468155, 6927.0, 3955.9011024724614, 3996.2407142643096, 4005.339119045383, 4014.036631208489, 4021.577734337911, 2318.431984163874, 2548.719640839506, 2662.7204143565036, 2667.213172114231, 2689.744474274941, 840.8738689196608, 857.4041041476177, 861.8060936289347, 883.730462209026, 900.9864852027225, 9020.0, 9031.232345250595, 9115.908840911572, 9150.81698366029, 9188.816223675556, 3769.4157405602177, 3801.8669346572738, 3852.768833869977, 3910.4720862683744, 3911.041794760302, 7982.720604778805, 7983.880241796378, 7991.520508769376, 7998.4001199910235, 8001.359891208689, 3968.2261958917734, 3971.3645816669195, 3975.3241948868185, 3977.3039718049226, 3979.8010099495486, 3587.192881601619, 3597.6762091411897, 3603.8017909015257, 3607.314610224049, 3608.2061946371755, 3291.835408229579, 3304.256542277968, 3306.9338613228083, 3331.1672081979505, 3344.3812894614575, 1026.4354604967239, 1031.8142734307746, 1069.7539565899888, 1070.03162138265, 1070.5075665194097, 788.3141666749964, 851.9648626918324, 1153.5212886651946, 1164.2374244869625, 1169.3217933598492, 6521.804345869631, 6593.011048342691, 6597.109390232353, 6617.569857959217, 6618.966905165444, 952.4713783849892, 1023.4319952426326, 1035.409816404642, 1040.6305761454726, 1066.3761699405934, 4983.750812459362, 4999.700017998932, 5040.924386134211, 5061.544460998528, 5062.190049592121, 8028.678852845821, 8160.918390816135, 8257.0, 8285.461445006054, 8351.331893448509, 8154.062282837431, 8171.591420428955, 8222.671093156207, 8238.876416853753, 8336.66653333872, 6177.382261773877, 6329.905051424233, 6435.806925792233, 6443.4523065539015, 6463.159789227464, 6524.641144737085, 6592.538522303393, 6620.900686489803, 6622.668866556749, 6624.503162262753, 7411.258874112761, 7440.62796860144, 7442.96278518604, 7533.3973282138395, 7541.4343924207005, 7528.284812942762, 7636.389088872766, 7709.190534993745, 7736.1490236075115, 7817.413693972861, 5935.872184284972, 6000.8499787503915, 6008.309044459943, 6016.217891674054, 6020.518358531394, 6277.905831412441, 6278.874422511432, 6559.836004099936, 6570.934290657032, 6599.9010014848855, 6075.179850720273, 6083.6349819011, 6205.906911396242, 6215.409536094064, 6266.780662676784, 5819.0, 5832.708364581838, 5883.823485295448, 5899.144624029406, 6050.485708714808, 6213.844653883689, 6226.50187984951, 6244.5316601256, 6266.874662506633, 6270.2475702915945, 5722.256106706268, 5755.625884317506, 5774.451427114417, 5775.797847075332, 5781.132830075522, 5117.2835802986865, 5696.0, 5741.885162296647, 5746.310442746897, 5747.224124743107], "unit": "ms", "name": "mootools.html", "value": 3953.687882972279}, {"lowerIsBetter": false, "replicates": [308.9505679091345, 315.575550884061, 316.8811695614144, 321.13294105914036, 321.8632081365421, 5245.213218017299, 5308.70802105884, 5383.676979381235, 5393.622446428752, 5396.109641909085, 5167.870803229921, 5297.258383826267, 5311.814086506973, 5320.680759154454, 5329.227262047001, 4206.41110244566, 4207.347861081522, 4210.2842516772225, 4219.409282700424, 4223.260929337369, 3945.191235796655, 4040.4545386372906, 4079.2453396121664, 4205.3481710334945, 4223.13425747721, 4178.958210417903, 4181.770002649853, 4182.53992060873, 4194.161167766459, 4211.68412369072, 4180.707350485467, 4182.121754431558, 4202.474690663667, 4203.432536607549, 4204.642605378546, 3709.684676802475, 3714.758540694846, 3716.684081853046, 3718.2749363874054, 3718.4050551911564, 5021.096202683516, 5131.4098878629065, 5146.691198528063, 5159.14874045782, 5169.534741873212, 4784.091022705675, 4792.832250871203, 4799.520047995207, 4799.952000479985, 4814.085323788469, 5608.523275521586, 5619.438056194389, 5623.240862483553, 5631.324241091095, 5631.662100273997, 3763.284975854579, 3870.4968354113785, 3873.8644147454984, 4005.619466150711, 4019.979900100481, 5870.0, 5896.0, 5899.0, 5900.55745819061, 5903.291605007426, 4141.544430112685, 4142.399352093989, 4144.150449157915, 4144.611555129005, 4147.875563733093, 4201.45381100455, 4216.768077755692, 4223.113146239262, 4224.0, 4224.831006759757, 4647.930281045787, 4767.070421267819, 4782.856514304576, 4784.114938736345, 4795.784189711471, 5619.241402410704, 5621.7751289948765, 5622.297212848394, 5624.325080990226, 5624.465675760796, 1468.0, 1495.0207614012838, 1497.445945000357, 1497.445945000357, 1497.8951473396976, 1036.8081904847627, 1040.7398150462384, 1042.7028296935337, 1054.2725519391595, 1066.0512144191675, 4932.136876046678, 4953.479884612064, 4955.801767929314, 4955.851324460272, 4965.0, 5832.12518122285, 5833.970830145907, 5834.533237341003, 5836.8540786479825, 5837.686520532931, 4946.901061978812, 4954.677945933503, 4957.157283261854, 4961.925571116436, 4963.875903102451, 3075.7539396848647, 3102.9224269393444, 3119.984400077985, 3140.6702296259023, 3149.4803357445767, 5455.236266922634, 5486.670799752028, 5505.862353441116, 5517.089680202802, 5525.171224316305, 5940.495057920039, 5949.672767997715, 5955.28536575605, 5959.821205363846, 5964.075568286922, 5479.2602998594675, 5494.1758736189895, 5494.846082322677, 5495.642783219078, 5517.586181036358, 5643.463870932255, 5818.854528636818, 5819.534437244925, 5823.475887170175, 5824.922389357982, 5461.890762184814, 5623.297087864017, 5624.465675760796, 5676.375598684059, 5685.431456854281, 5409.540189083972, 5518.3377994639295, 5543.861403464945, 5553.16702494629, 5562.943040822231, 4045.5752146024242, 4048.2308361411237, 4050.10897602527, 4055.1281474483126, 4059.3707975263883, 5739.253896993364, 5835.387284335254, 5843.766249350148, 5853.326867410132, 5855.38518455556, 5595.07681232592, 5609.158626205938, 5614.326280846324, 5616.269884914935, 5618.297712785902, 5605.691686957093, 5610.18652295423, 5614.242077319673, 5614.905093506727, 5617.297837770278, 5499.807506737245, 5503.899220156065, 5506.513241424873, 5517.724113794375, 5527.226188333717, 5525.336959564717, 5669.404712505293, 5671.517920976598, 5677.51741102011, 5680.204771331934, 5536.280283563272, 5536.446355364431, 5536.446355364593, 5538.833834984957, 5543.528800051879], "unit": "ms", "name": "prototype.html", "value": 4254.308962376857}, {"lowerIsBetter": false, "replicates": [637.8947473666846, 661.6790856434628, 665.3047565294269, 675.2369822101025, 751.4476859508261, 10347.327423717454, 10596.364218146917, 11019.118470522359, 11026.062784663292, 11028.338299702013, 11307.717307067327, 11415.086793056556, 11426.028787553068, 11431.714207144825, 11440.771184576304, 604.4469310580813, 611.8103387949727, 731.959742214178, 738.3760722189741, 745.0351794426203, 746.8319628083692, 747.4244831479757, 752.5898385379953, 753.8228516298666, 754.3587950242305, 630.5838146823098, 786.0096278688865, 786.3316181245953, 793.3692714292151, 793.6230290611942, 633.189517417706, 775.7401270574364, 799.588212070784, 800.3117319105564, 800.4076983032514, 571.434280062739, 576.7894718427743, 576.815419065899, 576.8846230753866, 577.5177726598296, 10841.295315804447, 10937.507812148473, 10940.726481837939, 10952.397618130999, 10961.725956851064, 10687.465626718711, 10759.731006724895, 11004.449777511172, 11267.492962816694, 11763.176577639482, 8941.776455588597, 8991.0, 9050.954745226298, 9149.908500915039, 9179.541022948826, 3214.4374734421617, 3248.675132486756, 3265.0, 3267.15054085937, 3267.248532837437, 40569.1886162278, 40780.0, 41184.79407602973, 41198.79400602978, 41523.792381038205, 8855.73432797017, 8866.778330541789, 8873.201411872962, 8893.73318800437, 8934.061923497939, 17100.91449542744, 17163.0, 17167.484975450756, 17173.484795456156, 17287.65424691499, 6294.685265736694, 6326.082718005863, 6463.256725476536, 6485.740570377132, 6501.447376972916, 3428.6228514863346, 3438.0717206354143, 3445.8621655134016, 3478.3217272631596, 3496.423090190141, 2710.715374885648, 2727.495413348497, 2742.4240909409245, 2750.0, 2750.546159883637, 480.4042986696541, 486.3992968683673, 493.10009233149646, 499.8425495968758, 501.1030255842075, 463.8496528609068, 498.7157320327451, 510.12037050847755, 513.4249640402772, 524.3498062402593, 7011.89482157768, 7212.639368031682, 7942.126366099725, 8271.2142346477, 8605.354598405145, 401.4921124777159, 421.2396624093541, 458.9036302376472, 468.063872255489, 540.7053156029973, 3268.1829542614346, 3280.676813568086, 3364.327134573095, 3422.1615704152146, 3547.7161827053774, 48964.0, 49936.750316248916, 50287.49712502901, 50348.49651503438, 50398.244026339635, 45056.54943450589, 45587.54412455899, 46234.768826155654, 46500.0, 46870.765646172236, 41449.0, 41925.580744192775, 41946.16107677829, 42272.365914510694, 42585.78707106445, 6772.52592318533, 7069.293070692889, 7128.180259270251, 7213.062301900719, 7276.672549735169, 33560.0, 33874.83062584671, 33922.66077339195, 34303.31393372069, 34631.82684086564, 38625.80687096546, 38758.4186237201, 39268.60731392649, 39357.409638854864, 39471.407928881665, 9292.814143717223, 9372.531373431437, 9384.718458446258, 9455.0, 9792.265580081379, 10175.135113515138, 10302.22733294991, 10485.737856553647, 10580.84128738085, 11044.0, 9505.192058674813, 9798.167155791838, 10198.694039178836, 10204.591816327264, 10275.691729248134, 10324.328918620266, 10336.896631033593, 10491.160707143257, 10582.365058096539, 10677.252592318464, 9009.81980360376, 9443.669471568463, 9630.181434577858, 9717.951410242904, 9744.317897747089, 7920.960395197987, 7927.603619819101, 8064.55644939534, 8263.83472330538, 8341.749747507585, 7786.922130778847, 7846.725364612211, 7855.764327070197, 7986.92013079885, 8203.179682031749], "unit": "ms", "name": "yui.html", "value": 5458.443023602808}], "name": "dromaeo_css", "value": 6190.129143373412}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 116.0, 107.0, 112.0, 112.0, 112.0, 105.0, 114.0, 113.0, 105.0], "unit": "ms", "name": "ai-astar", "value": 110.9}, {"lowerIsBetter": true, "replicates": [151.0, 130.0, 149.0, 173.0, 138.0, 148.0, 149.0, 140.0, 174.0, 128.0], "unit": "ms", "name": "audio-beat-detection", "value": 148.0}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 161.0, 160.0, 159.0, 160.0, 165.0, 162.0, 162.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 161.2}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 82.0, 97.0, 72.0, 72.0, 72.0, 100.0, 97.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 80.9}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 133.0, 94.0, 94.0, 95.0, 137.0, 94.0, 94.0, 128.0], "unit": "ms", "name": "audio-oscillator", "value": 105.8}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 109.0, 110.0, 110.0, 109.0, 109.0, 109.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.2}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.0}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 70.0, 69.0, 70.0, 70.0, 69.0, 71.0, 72.0, 69.0], "unit": "ms", "name": "json-parse-financial", "value": 70.0}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 69.0, 68.0, 68.0, 69.0, 69.0, 68.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.6}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 83.0, 84.0, 82.0, 83.0, 84.0, 91.0, 85.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.0}, {"lowerIsBetter": true, "replicates": [123.0, 127.0, 141.0, 118.0, 126.0, 127.0, 133.0, 123.0, 121.0, 121.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 126.0}, {"lowerIsBetter": true, "replicates": [137.0, 138.0, 148.0, 140.0, 162.0, 138.0, 142.0, 146.0, 152.0, 165.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 146.8}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 69.0, 68.0, 72.0, 69.0, 70.0, 70.0, 69.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.5}], "name": "kraken", "value": 1522.2999999999997}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [190.91256204658268], "unit": "score", "name": "Richards", "value": 184.91187600000003}, {"lowerIsBetter": false, "replicates": [191.64430816404752], "unit": "score", "name": "DeltaBlue", "value": 345.00372400000015}, {"lowerIsBetter": false, "replicates": [279.01785714285717], "unit": "score", "name": "Encrypt", "value": 953.9927040000001}, {"lowerIsBetter": false, "replicates": [5000.0], "unit": "score", "name": "Decrypt", "value": 53.23619999999997}, {"lowerIsBetter": false, "replicates": [1955.078125], "unit": "score", "name": "RayTrace", "value": 378.49587212787225}, {"lowerIsBetter": false, "replicates": [787.4015748031496], "unit": "score", "name": "Earley", "value": 846.4080099999996}, {"lowerIsBetter": false, "replicates": [12048.192771084337], "unit": "score", "name": "Boyer", "value": 55.31642899999996}, {"lowerIsBetter": false, "replicates": [26710.526315789473], "unit": "score", "name": "RegExp", "value": 34.105842364532016}, {"lowerIsBetter": false, "replicates": [616.9031462060457], "unit": "score", "name": "Splay", "value": 132.096911}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 19575.841498126523}]} 09:28:51 INFO - RETURN: dromaeo_css: 6190.13 09:28:51 INFO - RETURN: kraken: 1522.30 09:28:51 INFO - RETURN: v8_7: 19575.84 09:28:51 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19575.84"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1522.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6190.13"}}} 09:28:51 INFO - Return code: 0 09:28:51 INFO - # TBPL SUCCESS # 09:28:51 INFO - Running post-action listener: _resource_record_post_action 09:28:51 INFO - Running post-run listener: _resource_record_post_run 09:28:52 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 4096; Write bytes: 513343488; Read time: 28; Write time: 726680 09:28:52 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 173858816; Read time: 0; Write time: 298288 09:28:52 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 4096; Write bytes: 272556032; Read time: 28; Write time: 197664 09:28:52 INFO - Running post-run listener: _upload_blobber_files 09:28:52 INFO - Blob upload gear active. 09:28:52 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 09:28:52 INFO - Copying logs to upload dir... 09:28:52 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1272.378444 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-11-23 09:28:52.077889) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 09:28:52.081293) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1448298236.934799-708591809 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/rgWqqQjYRByA4tSThUtIJA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009949 build_url: 'https://queue.taskcluster.net/v1/task/rgWqqQjYRByA4tSThUtIJA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 09:28:52.134461) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 09:28:52.134873) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1448298236.934799-708591809 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004654 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 09:28:52.187514) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 09:28:52.188018) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 09:28:52.188435) ========= ========= Total master_lag: 0.22 =========