builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-056 starttime: 1448285973.26 results: success (0) buildid: 20151123050554 builduid: 1951b743c8f04fd2b9d29c2608cfd14d revision: 5c614c8507b7c7928ffbe5cc3a884d7c55c9405b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 05:39:33.265130) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 05:39:33.265625) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 05:39:33.266060) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0ae9de487587ba4b94dd3100000001b5-1448285659.242344-1684323083 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006497 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 05:39:33.301595) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 05:39:33.301876) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 05:39:33.342971) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 05:39:33.343264) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0ae9de487587ba4b94dd3100000001b5-1448285659.242344-1684323083 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004742 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 05:39:33.399936) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 05:39:33.400245) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 05:39:33.400583) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 05:39:33.401028) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0ae9de487587ba4b94dd3100000001b5-1448285659.242344-1684323083 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-23 05:39:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2015-11-23 05:39:33 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.113196 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 05:39:33.528391) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 05:39:33.528657) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0ae9de487587ba4b94dd3100000001b5-1448285659.242344-1684323083 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019121 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 05:39:33.583960) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 05:39:33.584257) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5c614c8507b7c7928ffbe5cc3a884d7c55c9405b --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 5c614c8507b7c7928ffbe5cc3a884d7c55c9405b --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0ae9de487587ba4b94dd3100000001b5-1448285659.242344-1684323083 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-23 05:39:33,729 truncating revision to first 12 chars 2015-11-23 05:39:33,730 Setting DEBUG logging. 2015-11-23 05:39:33,730 attempt 1/10 2015-11-23 05:39:33,730 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5c614c8507b7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-23 05:39:34,234 unpacking tar archive at: fx-team-5c614c8507b7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.831589 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 05:39:34.429510) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 05:39:34.429933) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 05:39:34.437688) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 05:39:34.438007) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 05:39:34.438419) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2015-11-23 05:39:34.438716) ========= /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=0ae9de487587ba4b94dd3100000001b5-1448285659.242344-1684323083 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:39:34 INFO - MultiFileLogger online at 20151123 05:39:34 in /builds/slave/test 05:39:34 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 05:39:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:39:34 INFO - {'append_to_log': False, 05:39:34 INFO - 'base_work_dir': '/builds/slave/test', 05:39:34 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:39:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:39:34 INFO - 'branch': 'Fx-Team-Non-PGO', 05:39:34 INFO - 'buildbot_json_path': 'buildprops.json', 05:39:34 INFO - 'config_files': ('talos/linux_config.py',), 05:39:34 INFO - 'default_actions': ('clobber', 05:39:34 INFO - 'read-buildbot-config', 05:39:34 INFO - 'download-and-extract', 05:39:34 INFO - 'populate-webroot', 05:39:34 INFO - 'create-virtualenv', 05:39:34 INFO - 'install', 05:39:34 INFO - 'run-tests'), 05:39:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:39:34 INFO - 'download_minidump_stackwalk': True, 05:39:34 INFO - 'download_symbols': 'ondemand', 05:39:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:39:34 INFO - 'tooltool.py': '/tools/tooltool.py', 05:39:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:39:34 INFO - '/tools/misc-python/virtualenv.py')}, 05:39:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:39:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:39:34 INFO - 'installer_path': 'installer.exe', 05:39:34 INFO - 'log_level': 'info', 05:39:34 INFO - 'log_name': 'talos', 05:39:34 INFO - 'log_to_console': True, 05:39:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:39:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:39:34 INFO - 'opt_config_files': (), 05:39:34 INFO - 'pip_index': False, 05:39:34 INFO - 'sps_profile': False, 05:39:34 INFO - 'sps_profile_interval': 0, 05:39:34 INFO - 'suite': 'dromaeojs', 05:39:34 INFO - 'system_bits': '64', 05:39:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:39:34 INFO - 'title': 'talos-linux64-ix-056', 05:39:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:39:34 INFO - 'use_talos_json': True, 05:39:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:39:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:39:34 INFO - 'work_dir': 'build'} 05:39:34 INFO - ##### 05:39:34 INFO - ##### Running clobber step. 05:39:34 INFO - ##### 05:39:34 INFO - Running pre-action listener: _resource_record_pre_action 05:39:34 INFO - Running main action method: clobber 05:39:34 INFO - rmtree: /builds/slave/test/build 05:39:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:39:35 INFO - Running post-action listener: _resource_record_post_action 05:39:35 INFO - ##### 05:39:35 INFO - ##### Running read-buildbot-config step. 05:39:35 INFO - ##### 05:39:35 INFO - Running pre-action listener: _resource_record_pre_action 05:39:35 INFO - Running main action method: read_buildbot_config 05:39:35 INFO - Using buildbot properties: 05:39:35 INFO - { 05:39:35 INFO - "properties": { 05:39:35 INFO - "buildnumber": 903, 05:39:35 INFO - "product": "firefox", 05:39:35 INFO - "script_repo_revision": "production", 05:39:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:39:35 INFO - "repository": "", 05:39:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 05:39:35 INFO - "buildid": "20151123050554", 05:39:35 INFO - "slavename": "talos-linux64-ix-056", 05:39:35 INFO - "pgo_build": "False", 05:39:35 INFO - "basedir": "/builds/slave/test", 05:39:35 INFO - "project": "", 05:39:35 INFO - "platform": "ubuntu64_hw", 05:39:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:39:35 INFO - "slavebuilddir": "test", 05:39:35 INFO - "scheduler": "tests-fx-team-linux64-talos", 05:39:35 INFO - "branch": "fx-team", 05:39:35 INFO - "repo_path": "integration/fx-team", 05:39:35 INFO - "stage_platform": "linux64", 05:39:35 INFO - "builduid": "1951b743c8f04fd2b9d29c2608cfd14d", 05:39:35 INFO - "revision": "5c614c8507b7c7928ffbe5cc3a884d7c55c9405b" 05:39:35 INFO - }, 05:39:35 INFO - "sourcestamp": { 05:39:35 INFO - "repository": "", 05:39:35 INFO - "hasPatch": false, 05:39:35 INFO - "project": "", 05:39:35 INFO - "branch": "fx-team-linux64-talos", 05:39:35 INFO - "changes": [ 05:39:35 INFO - { 05:39:35 INFO - "category": null, 05:39:35 INFO - "files": [ 05:39:35 INFO - { 05:39:35 INFO - "url": null, 05:39:35 INFO - "name": "https://queue.taskcluster.net/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 05:39:35 INFO - } 05:39:35 INFO - ], 05:39:35 INFO - "repository": "", 05:39:35 INFO - "rev": "5c614c8507b7c7928ffbe5cc3a884d7c55c9405b", 05:39:35 INFO - "who": "pbrosset@mozilla.com", 05:39:35 INFO - "when": 1448285946, 05:39:35 INFO - "number": 6694867, 05:39:35 INFO - "comments": "Bug 1198073 - Introduce a pref to set the max length of attributes or not truncat them; r=pbro", 05:39:35 INFO - "project": "", 05:39:35 INFO - "at": "Mon 23 Nov 2015 05:39:06", 05:39:35 INFO - "branch": "fx-team-linux64-talos", 05:39:35 INFO - "revlink": "", 05:39:35 INFO - "properties": [ 05:39:35 INFO - [ 05:39:35 INFO - "buildid", 05:39:35 INFO - "20151123050554", 05:39:35 INFO - "Change" 05:39:35 INFO - ], 05:39:35 INFO - [ 05:39:35 INFO - "builduid", 05:39:35 INFO - "1951b743c8f04fd2b9d29c2608cfd14d", 05:39:35 INFO - "Change" 05:39:35 INFO - ], 05:39:35 INFO - [ 05:39:35 INFO - "pgo_build", 05:39:35 INFO - "False", 05:39:35 INFO - "Change" 05:39:35 INFO - ] 05:39:35 INFO - ], 05:39:35 INFO - "revision": "5c614c8507b7c7928ffbe5cc3a884d7c55c9405b" 05:39:35 INFO - } 05:39:35 INFO - ], 05:39:35 INFO - "revision": "5c614c8507b7c7928ffbe5cc3a884d7c55c9405b" 05:39:35 INFO - } 05:39:35 INFO - } 05:39:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 05:39:35 INFO - Running post-action listener: _resource_record_post_action 05:39:35 INFO - ##### 05:39:35 INFO - ##### Running download-and-extract step. 05:39:35 INFO - ##### 05:39:35 INFO - Running pre-action listener: _resource_record_pre_action 05:39:35 INFO - Running main action method: download_and_extract 05:39:35 INFO - mkdir: /builds/slave/test/build/tests 05:39:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:35 INFO - https://queue.taskcluster.net/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:39:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/test_packages.json 05:39:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/test_packages.json 05:39:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 05:39:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 05:39:36 INFO - Downloaded 1302 bytes. 05:39:36 INFO - Reading from file /builds/slave/test/build/test_packages.json 05:39:36 INFO - Using the following test package requirements: 05:39:36 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:39:36 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:36 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:39:36 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:36 INFO - u'jsshell-linux-x86_64.zip'], 05:39:36 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:36 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:39:36 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:39:36 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:36 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:39:36 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:36 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:39:36 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:36 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:39:36 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:39:36 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:36 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:39:36 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:39:36 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')]} 05:39:36 INFO - https://queue.taskcluster.net/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:39:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:39:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:39:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/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 05:39:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/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 05:39:37 INFO - Downloaded 21339409 bytes. 05:39:37 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 05:39:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:39:37 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 05:39:38 INFO - Return code: 0 05:39:38 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 05:39:38 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')]} 05:39:38 INFO - https://queue.taskcluster.net/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:39:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:39:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:39:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/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 05:39:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/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 05:39:41 INFO - Downloaded 21339409 bytes. 05:39:41 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 05:39:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:39:41 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 05:39:42 INFO - Return code: 0 05:39:42 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')]} 05:39:42 INFO - https://queue.taskcluster.net/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:39:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:39:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:39:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/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 05:39:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/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 05:39:43 INFO - Downloaded 11130997 bytes. 05:39:43 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 05:39:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:39:43 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 05:39:43 INFO - Return code: 0 05:39:43 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')]} 05:39:43 INFO - https://queue.taskcluster.net/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:39:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:39:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:39:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/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 05:39:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/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 05:39:45 INFO - Downloaded 55911868 bytes. 05:39:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:39:45 INFO - mkdir: /builds/slave/test/properties 05:39:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:39:45 INFO - Writing to file /builds/slave/test/properties/build_url 05:39:45 INFO - Contents: 05:39:45 INFO - build_url:https://queue.taskcluster.net/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:39:45 INFO - Running post-action listener: _resource_record_post_action 05:39:45 INFO - Running post-action listener: set_extra_try_arguments 05:39:45 INFO - ##### 05:39:45 INFO - ##### Running populate-webroot step. 05:39:45 INFO - ##### 05:39:45 INFO - Running pre-action listener: _resource_record_pre_action 05:39:45 INFO - Running main action method: populate_webroot 05:39:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:39:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:39:45 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 05:39:45 INFO - '../fennec_ids.txt'], 05:39:45 INFO - 'tests': ['tcheck2']}, 05:39:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:39:45 INFO - '--tppagecycles', 05:39:45 INFO - '7'], 05:39:45 INFO - 'tests': ['tsvgm']}}, 05:39:45 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:39:45 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:39:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:39:45 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:39:45 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:39:45 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:39:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:39:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:45 INFO - 'talos_options': ['--e10s'], 05:39:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:39:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:45 INFO - 'tests': ['damp', 'tps']}, 05:39:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:45 INFO - 'talos_options': ['--e10s'], 05:39:45 INFO - 'tests': ['damp', 'tps']}, 05:39:45 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:39:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:39:45 INFO - 'other': {'tests': ['a11yr', 05:39:45 INFO - 'ts_paint', 05:39:45 INFO - 'tpaint', 05:39:45 INFO - 'sessionrestore', 05:39:45 INFO - 'sessionrestore_no_auto_restore']}, 05:39:45 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:39:45 INFO - 'tests': ['a11yr', 05:39:45 INFO - 'ts_paint', 05:39:45 INFO - 'tpaint', 05:39:45 INFO - 'sessionrestore', 05:39:45 INFO - 'sessionrestore_no_auto_restore']}, 05:39:45 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:39:45 INFO - 'tests': ['a11yr', 05:39:45 INFO - 'ts_paint', 05:39:45 INFO - 'tpaint', 05:39:45 INFO - 'sessionrestore', 05:39:45 INFO - 'sessionrestore_no_auto_restore']}, 05:39:45 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:39:45 INFO - 'tests': ['a11yr', 05:39:45 INFO - 'ts_paint', 05:39:45 INFO - 'tpaint', 05:39:45 INFO - 'sessionrestore', 05:39:45 INFO - 'sessionrestore_no_auto_restore']}, 05:39:45 INFO - 'other_l64': {'tests': ['a11yr', 05:39:45 INFO - 'ts_paint', 05:39:45 INFO - 'tpaint', 05:39:45 INFO - 'sessionrestore', 05:39:45 INFO - 'sessionrestore_no_auto_restore']}, 05:39:45 INFO - 'other_nol64': {'tests': ['a11yr', 05:39:45 INFO - 'ts_paint', 05:39:45 INFO - 'tpaint', 05:39:45 INFO - 'sessionrestore', 05:39:45 INFO - 'sessionrestore_no_auto_restore']}, 05:39:45 INFO - 'svgr': {'tests': ['tsvgx', 05:39:45 INFO - 'tsvgr_opacity', 05:39:45 INFO - 'tart', 05:39:45 INFO - 'tscrollx', 05:39:45 INFO - 'cart']}, 05:39:45 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:39:45 INFO - 'tests': ['tsvgx', 05:39:45 INFO - 'tsvgr_opacity', 05:39:45 INFO - 'tart', 05:39:45 INFO - 'tscrollx', 05:39:45 INFO - 'cart']}, 05:39:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:45 INFO - 'tests': ['tp5o']}, 05:39:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:45 INFO - 'talos_options': ['--e10s'], 05:39:45 INFO - 'tests': ['tp5o']}, 05:39:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:45 INFO - 'talos_options': ['--xperf_path', 05:39:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:39:45 INFO - 'tests': ['tp5n']}, 05:39:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:45 INFO - 'talos_options': ['--e10s', 05:39:45 INFO - '--xperf_path', 05:39:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:39:45 INFO - 'tests': ['tp5n']}}, 05:39:45 INFO - 'talos.zip': {'path': '', 05:39:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:39:45 INFO - Running post-action listener: _resource_record_post_action 05:39:45 INFO - ##### 05:39:45 INFO - ##### Running create-virtualenv step. 05:39:45 INFO - ##### 05:39:45 INFO - Running pre-action listener: _resource_record_pre_action 05:39:45 INFO - Running main action method: create_virtualenv 05:39:45 INFO - Creating virtualenv /builds/slave/test/build/venv 05:39:45 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 05:39:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:39:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:39:45 INFO - Using real prefix '/usr' 05:39:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:39:46 INFO - Installing distribute.............................................................................................................................................................................................done. 05:39:48 INFO - Installing pip.................done. 05:39:48 INFO - Return code: 0 05:39:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:39:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:48 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 0x7f26299b8c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258a6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x263b900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2681b70>, '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 0x26d2dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d3250>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1448285659.242344-1684323083', '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 05:39:48 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 05:39:48 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 05:39:48 INFO - Using env: {'DISPLAY': ':0', 05:39:48 INFO - 'HOME': '/home/cltbld', 05:39:48 INFO - 'LANG': 'en_US.UTF-8', 05:39:48 INFO - 'LANGUAGE': 'en_US:en', 05:39:48 INFO - 'LOGNAME': 'cltbld', 05:39:48 INFO - 'MAIL': '/var/mail/cltbld', 05:39:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:48 INFO - 'MOZ_NO_REMOTE': '1', 05:39:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:48 INFO - 'NO_EM_RESTART': '1', 05:39:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:48 INFO - 'PWD': '/builds/slave/test', 05:39:48 INFO - 'SHELL': '/bin/bash', 05:39:48 INFO - 'SHLVL': '1', 05:39:48 INFO - 'TERM': 'linux', 05:39:48 INFO - 'TMOUT': '86400', 05:39:48 INFO - 'USER': 'cltbld', 05:39:48 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1448285659.242344-1684323083', 05:39:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:48 INFO - '_': '/tools/buildbot/bin/python'} 05:39:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:48 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 05:39:48 INFO - Cleaning up... 05:39:48 INFO - Return code: 0 05:39:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:39:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:48 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 0x7f26299b8c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258a6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x263b900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2681b70>, '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 0x26d2dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d3250>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1448285659.242344-1684323083', '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 05:39:48 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 05:39:48 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 05:39:48 INFO - Using env: {'DISPLAY': ':0', 05:39:48 INFO - 'HOME': '/home/cltbld', 05:39:48 INFO - 'LANG': 'en_US.UTF-8', 05:39:48 INFO - 'LANGUAGE': 'en_US:en', 05:39:48 INFO - 'LOGNAME': 'cltbld', 05:39:48 INFO - 'MAIL': '/var/mail/cltbld', 05:39:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:48 INFO - 'MOZ_NO_REMOTE': '1', 05:39:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:48 INFO - 'NO_EM_RESTART': '1', 05:39:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:48 INFO - 'PWD': '/builds/slave/test', 05:39:48 INFO - 'SHELL': '/bin/bash', 05:39:48 INFO - 'SHLVL': '1', 05:39:48 INFO - 'TERM': 'linux', 05:39:48 INFO - 'TMOUT': '86400', 05:39:48 INFO - 'USER': 'cltbld', 05:39:48 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1448285659.242344-1684323083', 05:39:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:48 INFO - '_': '/tools/buildbot/bin/python'} 05:39:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:48 INFO - Downloading/unpacking psutil>=0.7.1 05:39:48 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 05:39:48 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 05:39:48 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 05:39:48 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 05:39:48 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 05:39:48 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 05:39:50 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 05:39:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:39:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:39:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:39:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:39:50 INFO - Installing collected packages: psutil 05:39:50 INFO - Running setup.py install for psutil 05:39:50 INFO - building 'psutil._psutil_linux' extension 05:39:50 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 05:39:50 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 05:39:50 INFO - building 'psutil._psutil_posix' extension 05:39:50 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 05:39:50 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 05:39:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:39:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:39:51 INFO - Successfully installed psutil 05:39:51 INFO - Cleaning up... 05:39:51 INFO - Return code: 0 05:39:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:39: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')]} 05:39:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39: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')]} 05:39:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:51 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 0x7f26299b8c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258a6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x263b900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2681b70>, '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 0x26d2dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d3250>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1448285659.242344-1684323083', '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 05:39:51 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 05:39:51 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 05:39:51 INFO - Using env: {'DISPLAY': ':0', 05:39:51 INFO - 'HOME': '/home/cltbld', 05:39:51 INFO - 'LANG': 'en_US.UTF-8', 05:39:51 INFO - 'LANGUAGE': 'en_US:en', 05:39:51 INFO - 'LOGNAME': 'cltbld', 05:39:51 INFO - 'MAIL': '/var/mail/cltbld', 05:39:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:51 INFO - 'MOZ_NO_REMOTE': '1', 05:39:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:51 INFO - 'NO_EM_RESTART': '1', 05:39:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:51 INFO - 'PWD': '/builds/slave/test', 05:39:51 INFO - 'SHELL': '/bin/bash', 05:39:51 INFO - 'SHLVL': '1', 05:39:51 INFO - 'TERM': 'linux', 05:39:51 INFO - 'TMOUT': '86400', 05:39:51 INFO - 'USER': 'cltbld', 05:39:51 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1448285659.242344-1684323083', 05:39:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:51 INFO - '_': '/tools/buildbot/bin/python'} 05:39:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:39:51 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 05:39:51 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 05:39:51 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 05:39:51 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 05:39:51 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 05:39:51 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 05:39:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:39:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:39:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:39:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:39:53 INFO - Installing collected packages: mozsystemmonitor 05:39:53 INFO - Running setup.py install for mozsystemmonitor 05:39:53 INFO - Successfully installed mozsystemmonitor 05:39:53 INFO - Cleaning up... 05:39:53 INFO - Return code: 0 05:39:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:39:53 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')]} 05:39:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:53 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')]} 05:39:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:53 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 0x7f26299b8c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258a6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x263b900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2681b70>, '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 0x26d2dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d3250>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1448285659.242344-1684323083', '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 05:39:53 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 05:39:53 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 05:39:53 INFO - Using env: {'DISPLAY': ':0', 05:39:53 INFO - 'HOME': '/home/cltbld', 05:39:53 INFO - 'LANG': 'en_US.UTF-8', 05:39:53 INFO - 'LANGUAGE': 'en_US:en', 05:39:53 INFO - 'LOGNAME': 'cltbld', 05:39:53 INFO - 'MAIL': '/var/mail/cltbld', 05:39:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:53 INFO - 'MOZ_NO_REMOTE': '1', 05:39:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:53 INFO - 'NO_EM_RESTART': '1', 05:39:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:53 INFO - 'PWD': '/builds/slave/test', 05:39:53 INFO - 'SHELL': '/bin/bash', 05:39:53 INFO - 'SHLVL': '1', 05:39:53 INFO - 'TERM': 'linux', 05:39:53 INFO - 'TMOUT': '86400', 05:39:53 INFO - 'USER': 'cltbld', 05:39:53 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1448285659.242344-1684323083', 05:39:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:53 INFO - '_': '/tools/buildbot/bin/python'} 05:39:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:53 INFO - Downloading/unpacking blobuploader==1.2.4 05:39:53 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 05:39:53 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 05:39:53 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 05:39:53 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 05:39:53 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 05:39:53 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 05:39:55 INFO - Downloading blobuploader-1.2.4.tar.gz 05:39:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:39:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:39:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:39:55 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 05:39:55 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 05:39:55 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 05:39:55 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 05:39:55 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 05:39:55 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 05:39:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:39:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:39:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:39:55 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 05:39:55 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 05:39:55 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 05:39:55 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 05:39:55 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 05:39:55 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 05:39:56 INFO - Downloading docopt-0.6.1.tar.gz 05:39:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:39:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:39:56 INFO - Installing collected packages: blobuploader, requests, docopt 05:39:56 INFO - Running setup.py install for blobuploader 05:39:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:39:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:39:56 INFO - Running setup.py install for requests 05:39:56 INFO - Running setup.py install for docopt 05:39:56 INFO - Successfully installed blobuploader requests docopt 05:39:56 INFO - Cleaning up... 05:39:56 INFO - Return code: 0 05:39:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:39: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')]} 05:39:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39: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')]} 05:39:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:56 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 0x7f26299b8c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258a6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x263b900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2681b70>, '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 0x26d2dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d3250>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1448285659.242344-1684323083', '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 05:39:56 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 05:39:56 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 05:39:56 INFO - Using env: {'DISPLAY': ':0', 05:39:56 INFO - 'HOME': '/home/cltbld', 05:39:56 INFO - 'LANG': 'en_US.UTF-8', 05:39:56 INFO - 'LANGUAGE': 'en_US:en', 05:39:56 INFO - 'LOGNAME': 'cltbld', 05:39:56 INFO - 'MAIL': '/var/mail/cltbld', 05:39:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:56 INFO - 'MOZ_NO_REMOTE': '1', 05:39:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:56 INFO - 'NO_EM_RESTART': '1', 05:39:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:56 INFO - 'PWD': '/builds/slave/test', 05:39:56 INFO - 'SHELL': '/bin/bash', 05:39:56 INFO - 'SHLVL': '1', 05:39:56 INFO - 'TERM': 'linux', 05:39:56 INFO - 'TMOUT': '86400', 05:39:56 INFO - 'USER': 'cltbld', 05:39:56 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1448285659.242344-1684323083', 05:39:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:56 INFO - '_': '/tools/buildbot/bin/python'} 05:39:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:39:57 INFO - Running setup.py (path:/tmp/pip-e6SP8H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:39:57 INFO - Running setup.py (path:/tmp/pip-vJxVU4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:39:57 INFO - Running setup.py (path:/tmp/pip-wBjhfN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:39:57 INFO - Running setup.py (path:/tmp/pip-TEt_qZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:39:57 INFO - Running setup.py (path:/tmp/pip-q4_Gmb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:39:57 INFO - Running setup.py (path:/tmp/pip-cBvTlO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:39:57 INFO - Running setup.py (path:/tmp/pip-wiARCr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:39:57 INFO - Running setup.py (path:/tmp/pip-QO31oN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:39:57 INFO - Running setup.py (path:/tmp/pip-jmtwJw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:39:57 INFO - Running setup.py (path:/tmp/pip-udRNc9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:39:57 INFO - Running setup.py (path:/tmp/pip-TUTZY0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:39:57 INFO - Running setup.py (path:/tmp/pip-DLDECc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:39:57 INFO - Running setup.py (path:/tmp/pip-y0Y_Qd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:39:57 INFO - Running setup.py (path:/tmp/pip-Y2auwD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:39:58 INFO - Running setup.py (path:/tmp/pip-kFxh5L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:39:58 INFO - Running setup.py (path:/tmp/pip-T9uAHx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:39:58 INFO - Running setup.py (path:/tmp/pip-l2f1Ve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:39:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:39:58 INFO - Running setup.py install for manifestparser 05:39:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:39:58 INFO - Running setup.py install for mozcrash 05:39:58 INFO - Running setup.py install for mozdebug 05:39:58 INFO - Running setup.py install for mozdevice 05:39:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:39:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:39:58 INFO - Running setup.py install for mozfile 05:39:58 INFO - Running setup.py install for mozhttpd 05:39:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:39:58 INFO - Running setup.py install for mozinfo 05:39:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:39:58 INFO - Running setup.py install for mozInstall 05:39:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:39:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:39:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:39:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:39:59 INFO - Running setup.py install for mozleak 05:39:59 INFO - Running setup.py install for mozlog 05:39:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:39:59 INFO - Running setup.py install for moznetwork 05:39:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:39:59 INFO - Running setup.py install for mozprocess 05:39:59 INFO - Running setup.py install for mozprofile 05:39:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:39:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:39:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:39:59 INFO - Running setup.py install for mozrunner 05:39:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:39:59 INFO - Running setup.py install for mozscreenshot 05:39:59 INFO - Running setup.py install for moztest 05:39:59 INFO - Running setup.py install for mozversion 05:39:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:39:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:39:59 INFO - Cleaning up... 05:39:59 INFO - Return code: 0 05:39:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:39:59 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')]} 05:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:59 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')]} 05:39:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:00 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 0x7f26299b8c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258a6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x263b900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2681b70>, '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 0x26d2dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d3250>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1448285659.242344-1684323083', '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 05:40:00 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 05:40:00 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 05:40:00 INFO - Using env: {'DISPLAY': ':0', 05:40:00 INFO - 'HOME': '/home/cltbld', 05:40:00 INFO - 'LANG': 'en_US.UTF-8', 05:40:00 INFO - 'LANGUAGE': 'en_US:en', 05:40:00 INFO - 'LOGNAME': 'cltbld', 05:40:00 INFO - 'MAIL': '/var/mail/cltbld', 05:40:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:00 INFO - 'MOZ_NO_REMOTE': '1', 05:40:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:00 INFO - 'NO_EM_RESTART': '1', 05:40:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:00 INFO - 'PWD': '/builds/slave/test', 05:40:00 INFO - 'SHELL': '/bin/bash', 05:40:00 INFO - 'SHLVL': '1', 05:40:00 INFO - 'TERM': 'linux', 05:40:00 INFO - 'TMOUT': '86400', 05:40:00 INFO - 'USER': 'cltbld', 05:40:00 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1448285659.242344-1684323083', 05:40:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:00 INFO - '_': '/tools/buildbot/bin/python'} 05:40:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:40:00 INFO - Running setup.py (path:/tmp/pip-t1XXF2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:40:00 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)) 05:40:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:40:00 INFO - Running setup.py (path:/tmp/pip-5Uqted-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:40:00 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)) 05:40:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:40:00 INFO - Running setup.py (path:/tmp/pip-I7FD1M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:40:00 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)) 05:40:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:40:00 INFO - Running setup.py (path:/tmp/pip-wp8aBv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:40:00 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)) 05:40:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:40:00 INFO - Running setup.py (path:/tmp/pip-1hUQAy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:40:00 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)) 05:40:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:40:00 INFO - Running setup.py (path:/tmp/pip-rGGrzI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:40:00 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)) 05:40:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:40:00 INFO - Running setup.py (path:/tmp/pip-ku4hvL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:40:00 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)) 05:40:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:40:00 INFO - Running setup.py (path:/tmp/pip-XGehIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:40:00 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)) 05:40:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:40:00 INFO - Running setup.py (path:/tmp/pip-Pnan3X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:40:00 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)) 05:40:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:40:00 INFO - Running setup.py (path:/tmp/pip-a4wRrA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:40:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:40:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:40:00 INFO - Running setup.py (path:/tmp/pip-Gs1lXB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:40:01 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)) 05:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:40:01 INFO - Running setup.py (path:/tmp/pip-tmMSRy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:40:01 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)) 05:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:40:01 INFO - Running setup.py (path:/tmp/pip-2jHZZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:40:01 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)) 05:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:40:01 INFO - Running setup.py (path:/tmp/pip-xbvuLJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:40:01 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)) 05:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:40:01 INFO - Running setup.py (path:/tmp/pip-OlFIuT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:40:01 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)) 05:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:40:01 INFO - Running setup.py (path:/tmp/pip-XPEYbK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:40:01 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)) 05:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:40:01 INFO - Running setup.py (path:/tmp/pip-PPwc0c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:40:01 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)) 05:40:01 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)) 05:40:01 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)) 05:40:01 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)) 05:40:01 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)) 05:40:01 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)) 05:40:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:40:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:03 INFO - Downloading blessings-1.5.1.tar.gz 05:40:03 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 05:40:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:40:03 INFO - Installing collected packages: blessings 05:40:03 INFO - Running setup.py install for blessings 05:40:03 INFO - Successfully installed blessings 05:40:03 INFO - Cleaning up... 05:40:03 INFO - Return code: 0 05:40:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:40:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:40:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:40:03 INFO - Reading from file tmpfile_stdout 05:40:03 INFO - Current package versions: 05:40:03 INFO - argparse == 1.2.1 05:40:03 INFO - blessings == 1.5.1 05:40:03 INFO - blobuploader == 1.2.4 05:40:03 INFO - docopt == 0.6.1 05:40:03 INFO - manifestparser == 1.1 05:40:03 INFO - mozInstall == 1.12 05:40:03 INFO - mozcrash == 0.16 05:40:03 INFO - mozdebug == 0.1 05:40:03 INFO - mozdevice == 0.47 05:40:03 INFO - mozfile == 1.2 05:40:03 INFO - mozhttpd == 0.7 05:40:03 INFO - mozinfo == 0.9 05:40:03 INFO - mozleak == 0.1 05:40:03 INFO - mozlog == 3.0 05:40:03 INFO - moznetwork == 0.27 05:40:03 INFO - mozprocess == 0.22 05:40:03 INFO - mozprofile == 0.27 05:40:03 INFO - mozrunner == 6.11 05:40:03 INFO - mozscreenshot == 0.1 05:40:03 INFO - mozsystemmonitor == 0.0 05:40:03 INFO - moztest == 0.7 05:40:03 INFO - mozversion == 1.4 05:40:03 INFO - psutil == 3.1.1 05:40:03 INFO - requests == 1.2.3 05:40:03 INFO - wsgiref == 0.1.2 05:40:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:40:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:03 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 0x7f26299b8c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258a6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x263b900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2681b70>, '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 0x26d2dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d3250>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1448285659.242344-1684323083', '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 05:40:03 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 05:40:03 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 05:40:03 INFO - Using env: {'DISPLAY': ':0', 05:40:03 INFO - 'HOME': '/home/cltbld', 05:40:03 INFO - 'LANG': 'en_US.UTF-8', 05:40:03 INFO - 'LANGUAGE': 'en_US:en', 05:40:03 INFO - 'LOGNAME': 'cltbld', 05:40:03 INFO - 'MAIL': '/var/mail/cltbld', 05:40:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:03 INFO - 'MOZ_NO_REMOTE': '1', 05:40:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:03 INFO - 'NO_EM_RESTART': '1', 05:40:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:03 INFO - 'PWD': '/builds/slave/test', 05:40:03 INFO - 'SHELL': '/bin/bash', 05:40:03 INFO - 'SHLVL': '1', 05:40:03 INFO - 'TERM': 'linux', 05:40:03 INFO - 'TMOUT': '86400', 05:40:03 INFO - 'USER': 'cltbld', 05:40:03 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1448285659.242344-1684323083', 05:40:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:03 INFO - '_': '/tools/buildbot/bin/python'} 05:40:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:03 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)) 05:40:03 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)) 05:40:03 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)) 05:40:03 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)) 05:40:03 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)) 05:40:03 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)) 05:40:03 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)) 05:40:03 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)) 05:40:03 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)) 05:40:03 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)) 05:40:03 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)) 05:40:03 INFO - Cleaning up... 05:40:03 INFO - Return code: 0 05:40:03 INFO - Running post-action listener: _resource_record_post_action 05:40:03 INFO - Running post-action listener: _start_resource_monitoring 05:40:03 INFO - Starting resource monitoring. 05:40:03 INFO - ##### 05:40:03 INFO - ##### Running install step. 05:40:03 INFO - ##### 05:40:03 INFO - Running pre-action listener: _resource_record_pre_action 05:40:03 INFO - Running main action method: install 05:40:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:40:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:40:04 INFO - Reading from file tmpfile_stdout 05:40:04 INFO - Detecting whether we're running mozinstall >=1.0... 05:40:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:40:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:40:04 INFO - Reading from file tmpfile_stdout 05:40:04 INFO - Output received: 05:40:04 INFO - Usage: mozinstall [options] installer 05:40:04 INFO - Options: 05:40:04 INFO - -h, --help show this help message and exit 05:40:04 INFO - -d DEST, --destination=DEST 05:40:04 INFO - Directory to install application into. [default: 05:40:04 INFO - "/builds/slave/test"] 05:40:04 INFO - --app=APP Application being installed. [default: firefox] 05:40:04 INFO - mkdir: /builds/slave/test/build/application 05:40:04 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'] 05:40:04 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 05:40:18 INFO - Reading from file tmpfile_stdout 05:40:18 INFO - Output received: 05:40:18 INFO - /builds/slave/test/build/application/firefox/firefox 05:40:18 INFO - Running post-action listener: _resource_record_post_action 05:40:18 INFO - ##### 05:40:18 INFO - ##### Running run-tests step. 05:40:18 INFO - ##### 05:40:18 INFO - Running pre-action listener: _resource_record_pre_action 05:40:18 INFO - Running main action method: run_tests 05:40:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:40:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:40:18 INFO - Python 2.7.3 05:40:18 INFO - Return code: 0 05:40:18 INFO - grabbing minidump binary from tooltool 05:40:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:18 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 0x2681b70>, '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 0x26d2dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d3250>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:40:18 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 05:40:18 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 05:40:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:40:18 INFO - Return code: 0 05:40:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:40:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:40:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:40:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:40:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:40:18 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/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost'] in /builds/slave/test/build 05:40:18 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/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --webServer localhost 05:40:18 INFO - Using env: {'DISPLAY': ':0', 05:40:18 INFO - 'HOME': '/home/cltbld', 05:40:18 INFO - 'LANG': 'en_US.UTF-8', 05:40:18 INFO - 'LANGUAGE': 'en_US:en', 05:40:18 INFO - 'LOGNAME': 'cltbld', 05:40:18 INFO - 'MAIL': '/var/mail/cltbld', 05:40:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:40:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:40:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:18 INFO - 'MOZ_NO_REMOTE': '1', 05:40:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:40:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:18 INFO - 'NO_EM_RESTART': '1', 05:40:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:18 INFO - 'PWD': '/builds/slave/test', 05:40:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:40:18 INFO - 'SHELL': '/bin/bash', 05:40:18 INFO - 'SHLVL': '1', 05:40:18 INFO - 'TERM': 'linux', 05:40:18 INFO - 'TMOUT': '86400', 05:40:18 INFO - 'USER': 'cltbld', 05:40:18 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1448285659.242344-1684323083', 05:40:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:18 INFO - '_': '/tools/buildbot/bin/python'} 05:40:18 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/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost'] with output_timeout 3600 05:40:18 INFO - mozversion INFO | application_buildid: 20151123050554 05:40:18 INFO - mozversion INFO | application_changeset: 5c614c8507b7c7928ffbe5cc3a884d7c55c9405b 05:40:18 INFO - mozversion INFO | application_display_name: Nightly 05:40:18 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:40:18 INFO - mozversion INFO | application_name: Firefox 05:40:18 INFO - mozversion INFO | application_remotingname: firefox 05:40:18 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 05:40:18 INFO - mozversion INFO | application_vendor: Mozilla 05:40:18 INFO - mozversion INFO | application_version: 45.0a1 05:40:18 INFO - mozversion INFO | platform_buildid: 20151123050554 05:40:18 INFO - mozversion INFO | platform_changeset: 5c614c8507b7c7928ffbe5cc3a884d7c55c9405b 05:40:18 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 05:40:18 INFO - mozversion INFO | platform_version: 45.0a1 05:40:18 INFO - 2015-11-23 05:40:18,502 DEBUG : using testdate: 1448286018 05:40:18 INFO - 2015-11-23 05:40:18,502 DEBUG : actual date: 1448286018 05:40:18 INFO - 2015-11-23 05:40:18,593 INFO : starting webserver on 'localhost:39850' 05:40:18 INFO - 2015-11-23 05:40:18,594 INFO : Starting test suite talos-linux64-ix-056 05:40:18 INFO - 2015-11-23 05:40:18,594 INFO : Starting test dromaeo_css 05:40:18 INFO - 2015-11-23 05:40:18,594 DEBUG : operating with platform_type : linux_ 05:40:18 INFO - 2015-11-23 05:40:18,595 INFO : Initialising browser for dromaeo_css test... 05:40:18 INFO - 2015-11-23 05:40:18,610 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpy2ZnwO/profile http://localhost:39850/getInfo.html 05:40:23 INFO - 2015-11-23 05:40:23,103 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:40:23 INFO - 2015-11-23 05:40:23,103 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:40:23 INFO - 2015-11-23 05:40:23,103 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:40:23 INFO - 2015-11-23 05:40:23,103 DEBUG : BROWSER_OUTPUT: __metrics 05:40:23 INFO - 2015-11-23 05:40:23,292 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:40:24 INFO - 2015-11-23 05:40:24,630 INFO : Browser initialized. 05:40:24 INFO - 2015-11-23 05:40:24,631 INFO : Running cycle 1/1 for dromaeo_css test... 05:40:24 INFO - 2015-11-23 05:40:24,631 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpy2ZnwO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:40:36 INFO - 2015-11-23 05:40:36,544 DEBUG : BROWSER_OUTPUT: RSS: Main: 140279808 05:40:36 INFO - 2015-11-23 05:40:36,544 DEBUG : BROWSER_OUTPUT: 05:41:28 INFO - 2015-11-23 05:41:28,046 DEBUG : BROWSER_OUTPUT: 1448286088045 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] 05:43:40 INFO - 2015-11-23 05:43:40,468 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39850/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39850/tests/dromaeo/cssquery-ext.html) 05:43:41 INFO - 2015-11-23 05:43:41,655 DEBUG : BROWSER_OUTPUT: RSS: Main: 247484416 05:43:41 INFO - 2015-11-23 05:43:41,655 DEBUG : BROWSER_OUTPUT: 05:46:44 INFO - 2015-11-23 05:46:44,246 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39850/tests/dromaeo/cssquery-ext.html (next: http://localhost:39850/tests/dromaeo/cssquery-jquery.html) 05:46:44 INFO - 2015-11-23 05:46:44,819 DEBUG : BROWSER_OUTPUT: RSS: Main: 222834688 05:46:44 INFO - 2015-11-23 05:46:44,819 DEBUG : BROWSER_OUTPUT: 05:49:46 INFO - 2015-11-23 05:49:46,895 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39850/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39850/tests/dromaeo/cssquery-mootools.html) 05:49:47 INFO - 2015-11-23 05:49:47,476 DEBUG : BROWSER_OUTPUT: RSS: Main: 212422656 05:49:47 INFO - 2015-11-23 05:49:47,476 DEBUG : BROWSER_OUTPUT: 05:52:49 INFO - 2015-11-23 05:52:49,494 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39850/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39850/tests/dromaeo/cssquery-prototype.html) 05:52:50 INFO - 2015-11-23 05:52:50,063 DEBUG : BROWSER_OUTPUT: RSS: Main: 204083200 05:52:50 INFO - 2015-11-23 05:52:50,063 DEBUG : BROWSER_OUTPUT: 05:55:52 INFO - 2015-11-23 05:55:52,847 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39850/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39850/tests/dromaeo/cssquery-yui.html) 05:55:53 INFO - 2015-11-23 05:55:53,449 DEBUG : BROWSER_OUTPUT: RSS: Main: 209932288 05:55:53 INFO - 2015-11-23 05:55:53,449 DEBUG : BROWSER_OUTPUT: 05:58:56 INFO - 2015-11-23 05:58:56,059 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39850/tests/dromaeo/cssquery-yui.html (next: http://localhost:39850/tests/dromaeo/cssquery-dojo.html) 05:58:56 INFO - 2015-11-23 05:58:56,309 DEBUG : BROWSER_OUTPUT: RSS: Main: 228679680 05:58:56 INFO - 2015-11-23 05:58:56,309 DEBUG : BROWSER_OUTPUT: 05:58:56 INFO - 2015-11-23 05:58:56,311 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:58:56 INFO - 2015-11-23 05:58:56,311 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:58:56 INFO - 2015-11-23 05:58:56,311 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:58:56 INFO - 2015-11-23 05:58:56,311 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:58:56 INFO - 2015-11-23 05:58:56,312 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2631.4737052589485;2739.233014755869;2749.1340227828246;2751.29841890318;2762.944741105179;4533.682642215038;4650.953490465095;4669.836555720551;4707.929381059283;4748.26401907704;4616.122936642036;4627.814887404508;4659.4175728034;4666.300054991753;4666.486686464495;4298.441202643652;4341.088371442001;4366.650667946573;4427.424434823469;4431.667624928127;4117.505899292089;4362.258416069276;4398.142362239365;4428.689991700582;4471.575200355977;4231.682623803227;4240.597143271384;4296.548862369469;4308.224519586473;4350.260455722535;4281.165172791307;4334.826606935719;4338.067315527177;4341.5441378655105;4382.408374869416;4076.266272071026;4315.050688848449;4335.6965012449145;4342.848000319974;4382.101669157815;4521.570450807201;4538.364628951949;4570.588647021751;4652.767361631905;4696.882577935545;4995.125852975715;5014.047331007134;5014.097462456756;5016.372953380827;5037.949620503785;4818.542238487373;5019.623528235397;5027.84916452507;5029.798808047673;5077.390713114413;4622.768861556942;4629.65277604181;4637.489876113625;4686.086213188463;4754.976225118921;5144;5147.279380886679;5149.76826042829;5149.871253218699;5153.3558305211845;4723;4950.059488697136;4953.281774142802;4954.058728841508;4995.925061124086;4945.629077819178;4947.480514545993;4957.553820156131;4986.90026199474;5157.406898206679;5022.296878437021;5028.195488721787;5029.698218106925;5040.49595040493;5073.771680274396;4994.275830004629;4997.600191984705;5008.949910500921;5012.373453318335;5057.671251368723;3992.441058251847;4123.195976784558;4126.195391898611;4215.59951804578;4261.872143835628;3640.4903313536124;3699.408094704834;3703.9074023149637;3734.4958430612064;3744.588095309514;4332.0469496710675;4342.804573794187;4346.739195648208;4350.434443522322;4382.386465894777;4803.975980120077;4887.657863949489;4922.581580565692;5064.442911279756;5104.617153713486;4267.189234045583;4356.782160891943;4359.367891655692;4377.802998865059;4404.075144219686;4448.132614140276;4450.621697155713;4455.443069616298;4456.554344565518;4484.035932274576;4602.976985115053;4722.126406614787;4723.078999595046;4785.832495862628;4796.1127191468995;4861.052094841472;4926.679765815211;4939.135651261086;4959.231319145538;4988.326575912351;4799.400074990626;4857.368542089647;4863.902721945612;4869.074875773592;4905.632077594123;4749.667523273338;4868.537488938545;4870.610351171968;5022.271770593316;5090.745462726923;4980.825671101494;5039.395272567315;5062.949370506395;5072.82245121419;5107.846764597068;4942.505749425029;4949.183384741477;4955.900881982412;4957.504249575014;4997.525235102659;4661.510541393241;4727.976360118178;4776.546228108324;4938.530839570235;4983.75081245929;4737.928931066106;4792.568668819823;4812;4816.975915120402;4860.902781944271;4882.877928051827;4885.071836351082;4892.3884514435695;4912;4925.261210818263;4652.325412815055;4777.856664300077;4794.137055330074;4796.736179510161;4803.303520989367 05:58:56 INFO - 2015-11-23 05:58:56,314 DEBUG : BROWSER_OUTPUT: |1;ext.html;545.4273013335999;559.815260963882;562.7467639562198;572.4104172702116;575.8963386590412;27090.729092709065;27838.025669101586;38644.42033369498;39022.60977390225;39174.41238381426;41944.790276048654;42226.57773422265;42514.7874260629;42538.14923701532;42580.08389622466;7020.578765274075;7917.920820791776;8097.9595102024705;8098.392620553453;8100.594970251494;7107.6090815005155;10006.949965250164;10231.386116832977;10236.283460157792;10240.231982601335;10120.291579589431;10223.846642300372;10229.897701022968;10232.795344093114;10233.079022887938;7233.240509746453;7404.9629751851435;10021.298509104365;10089.545970431349;10192.286539942206;9584.95207523965;9761.755956101084;9763.463009534473;9766.023397660249;9769.853452198222;38807.41788873169;39155.60844391548;39234;39261.60738392608;39345.40981885274;2731.904383346593;2853.671827739816;2877.5252083406212;2929.6191495105713;3475.4960530722906;28507;28594.428111437865;28792.42415151706;29167.41665166706;29267.707322926923;3402.2515046689937;3428.879989200391;3451.36149812283;3507.4037413639744;3545.840437180333;237208;238356;238571;238782;239072;51513.22730159051;53160;53166.6833316673;55991;56572.717136414874;49395;49451.258231126565;59963.100553491735;60601.696991515644;60728.69635651793;11304.321740695585;11498.48256828428;11568.537258509734;11602.825957610643;11611.941940290244;8950.23922966555;9050.456972581665;9058;9074.047225041408;9081.68214112503;18397.90801045986;18878.716819247722;19133;19135.617287654168;19165.904170479338;7611.162772095176;7860.432128979325;7994.880076798852;8028.759137225892;8033.517988920684;770.9498882572615;811.7686459359054;842.7724514381083;853.423938841292;964.9723044957099;26427.339316516856;26800.840583616668;27181.86409067942;27222.183334499998;27276.590851137247;880.0231742765525;885.9158379954023;926.4441335198961;944.2351695126969;952.5761036338902;12686.936565317113;12771.297578633264;12846.807297890538;12873.35633218354;13012.674683132998;283838;285886;286055;286292;287330;38074.619253807665;38647.6135238644;43798.562014380084;44561.77719111449;46867;1142.948567314473;1145.9083273338113;1165.5046605192758;1167.5038108803724;1185.0815617896199;23351.649725254476;23811.76188238165;25701.87149064243;26805.731942680322;27018.1894543164;43124;43342.783286083366;43442.34836477392;43611.78194109009;43624.78187609042;225371;226815;226892;227004;227695;28518;28641.283967900137;28927.42145157127;28939.131826045254;28939.42121157607;39773;39779.60220397759;39789;40267.597324027556;40710;34456.310873781884;34908;35054.824725877224;35067;35451.468227977115;34702.47946280858;35052.64947350494;35496;37423;37641.81179094087;33149.17127071843;34099.829500852335;34133.65866341305;34153.48769768505;34167.31665366629;28044.859775700992;29958.5313046535;30322.241943951576;30580.541291881083;30790.230244243176;23266;24237.878810605835;24639;24939.251822445356;25817.612735809354 05:58:56 INFO - 2015-11-23 05:58:56,315 DEBUG : BROWSER_OUTPUT: |2;jquery.html;337.1671970233524;337.7736916266102;341.5355117040824;342.3717478427086;343.5448031358451;12545.498180072786;12883.54907578235;14914;15098;16422;14271.643208919782;14635.707285854303;14821.11073335598;14828.55514334569;15075.095494270352;3390.7965522068753;4473.88815279619;4595.839145629903;5019.949800502003;5022.522860328281;4993.400791904976;5018.5985121190215;5022.748862556876;5032.245163225509;5034.119029169899;4839.419269687643;4944.826931057413;4955.578775804061;4971.428285747131;5002.199648056312;5042.369703787008;5052.393712754475;5052.898942021139;5053.797848086072;5060.746962651871;4481.910361792746;4482.820687172509;4562.133194692998;4563.840265590721;4574.199515084847;11772.117091218108;11844.289342639384;11848.289102653782;11865.762684746256;15607.609809754733;1826.963460730778;1855.944321670352;1873.9250429982785;1916.9808301916942;1982.5241941933975;9100.499472529009;9347.112024357675;9755.902440975642;12557.121001529897;13161.539346122936;1734.7744793176805;1761.3483011285778;1762.5064981805115;1782.5116028116538;1814.5010122216363;45561.316580251325;45859.77070114695;46395.768021160016;46568.30147547789;51999.48000519984;9710.465924374086;9878.950605246928;9884.11043006133;9909.405435673883;9943.651972181084;10758.0855627271;10917.945410273056;12309.56916507918;12330.50677972889;21720.23979160722;7727.574983375968;7832;7868.685252589832;7874;7890.842183156419;5740.770369185269;5793.768249270066;6397.6801159941815;6442.581232219891;6448.097266382711;7410.814729631695;7600.2779735925;7633.480951286062;7645;7785.299323060952;2872.755815755684;2963.5702823090533;2972.8959486418303;2973.68776278492;2990.4467673480476;773.9071311442663;860.6342304520679;890.3055616619048;902.5261737587819;905.171767832426;15314.387424502895;15516.069035857885;15756.68486630284;15964.441244556385;15986;770.9653065612061;794.2375319693044;806.7418426103591;840.6931470013401;871.9258862996717;7003.824904377431;8809.823803523894;8843.847564299545;8961.103889610988;9463;506832;510147;529125;535232;536066;67078.32921670818;67385;67915.66042169757;68171;69910.65044674846;1000.9590026372637;1022.8363461846218;1063.984040239397;1082.3289560472558;1104.629948967089;13510.392032358764;13609.863901360859;13665;13763.38064787067;14051.297435128407;29555.261118472212;29767.404651907273;29815.85092074526;31405.214869628442;32540.674593253763;35546.46680299849;37220.62779372172;37385.2522949534;39293.41059884047;40230.597694023854;8357.791055223668;8427.157284271523;8653.956730216309;8735.475871447734;8766.34252431083;15248.16135112535;15249.23753812327;15505.922470387575;15584.766228506809;15642.061476311457;13288;13436.193828369938;13470.259135747629;13703.314834258048;14223.573292801233;13463.528776493167;13854;14036.78944815849;14098.295085245902;14317.498887538886;13981.790273145707;14178.858211418166;14188.858111418755;14412.711745764816;14704.485343012942;8490.872636910328;8743.475391476532;8833.602487887933;8867.556622168995;9032.909670903207;9069.002409734792;9147.039560846282;9151.267898568232;10759.731006724895;12602.432890520133 05:58:56 INFO - 2015-11-23 05:58:56,316 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1248.475640231103;1626.3657173702256;1664.850163485286;1682.0412364951983;1686.9072201028941;5816.505597024253;6186.257649082111;6376.266729326129;6389.5846769960035;6389.808305750829;6535.11775910252;6565.606063636185;6620.702068406921;6645.435138013275;6649.43479804216;1744.5551384397024;1771.123293969487;1775.4673597920637;2030.9289174878882;2050.2721533855492;1787.0350010994048;1788.7942886568017;2020;2041.8570700051002;2050.538628808521;1986.1261045140093;2015.1234213117268;2024.2307922989244;2026.4224695961655;2028.29009846554;2052.138101997165;2077.5948690005457;2080.791920807907;2082.2607974169177;2082.7188329575465;2026.6453370660222;2035.0130186859362;2061.7835127311714;2063.9587208255753;2069.379186244121;6592;6644.235912870034;6646.23568289648;6652.06871038055;6652.667366631649;3985.202959408101;4049.4128351389177;4050.5341885682933;4056.6349028587274;4057;2681.8927242910454;2720.8095433319677;2733.603627474025;2748.6014527893544;2759.65504311961;863.7797361672796;864.6498168241872;876.412803421709;878.8286284174525;896.7399454158286;8335.166483351677;8389.244967952853;8404.285635720971;8407.873881891777;8416.284615807665;3677.44838274261;3717.386631205821;3796.8291426885303;3797.487339209227;3828.444875493038;7417.740379086706;7471;7483.363914067257;7492.850142997109;7495.512791668524;4061.5329237137516;4086.223617512663;4089.8773036808943;4124;4129.855455059119;3725.5343082114737;3738.887833365003;3755.6807671348242;3756.887293381203;3757.4363845423404;2853.6432945881766;3253.3493301339354;3298;3339.348826978716;3343.8996830095134;937.6952490440634;1010.2069875147973;1017.4810846468206;1028.4806172882647;1041.068243921686;777.6150805351274;818.2349503214514;822.1778221778221;822.9588520574067;904.3759805734022;6074.665893375906;6135.049067394561;6186.505079593711;6194.225721784777;6196.132541444202;998.9001099890098;1000.7848312612823;1008.1481148429712;1019.2661283875598;1027.9691609251734;4977.402711674622;5054.16606259963;5056.165732654144;5058.772355243949;5061.240813877947;7600.46796724224;7655;7745.148033716287;7835.373170146375;7837.725679601301;7610.277023682741;7664.11862635804;7665.463417560717;7694;7734.265244801735;6067.544934129958;6127.5404344674325;6143.1706719592285;6184.165137706442;6197.81406557804;6211.9689401552705;6247.9062814056915;6248.562600617913;6312.589681670676;6314.810555683337;6660.6336651484635;7011.018457416068;7037.859242815218;7098.331892005272;7160.749373771893;7168.351279205916;7183.604901730246;7206.027186329988;7299;7382.889256661047;5963.642181469126;6037.607555508878;6039.63762174271;6050.394960503914;6052.122442245762;5701.230333904869;6484.319146489551;6519.641419721961;6534.117894084237;6540.051692504655;5604.579656525859;5734.569907257056;6042.274927008787;6095.817125486065;6136.079588061826;5896.823095307148;5974.731137098928;6035.818925432244;6050.878982420415;6106.816795496142;6049.969750151221;6063.696815159136;6091.756329746938;6099.207103076572;6099.786507472217;5690.146478028163;5723.399043100415;5734.684592347461;5739.942600573941;5745.109508026263;5503.889922201613;5584.329880414376;5815.3893841147765;5835.9708201458725;5846.883062338815 05:58:56 INFO - 2015-11-23 05:58:56,316 DEBUG : BROWSER_OUTPUT: |4;prototype.html;310.81661819526477;318.72908028176056;320.2138749370295;321.66225463263567;322.4824157227651;5298.7350632468315;5360.463953604638;5387.814680770229;5388.8922221555595;5413.918791218125;5069.923951140727;5097.59219262459;5203.089459344618;5302.522772950434;5342.385625653051;4167.083241686832;4181.080162364275;4206.369044643313;4222.15556888622;4229.513605935311;3986.8604598839047;4223;4224.556421575737;4227.788610569474;4237.7669228192435;4028.1742242840296;4057.5942405759483;4173.123644034757;4178.895527611819;4193.937090943638;4167.437395951538;4171.374293855946;4173.768738222232;4175.853845115436;4177.728447650893;3670.7981061041633;3672.320620685182;3682.0426689061037;3682.5396825396824;3683.797391143486;5127.897442051175;5183.974080129575;5197.168453047494;5207.3751149862255;5208.583313334924;4636.86089417318;4769.713817170981;4790.113828941657;4815.66290359675;4816;5702.486776190121;5706.201131841545;5710.543156547507;5713.314402271712;5714.542836573064;3983.50206224222;3992.900177495557;3995.220931918277;3996.0409501719378;3996.48045754053;5887.646741195542;5972.731227094791;5991.3109992351;5994.610350327258;6001.4298641628975;3966.5636779954184;4110.034141976633;4118.608732170439;4121.464209652786;4132.40080188377;4167.812448439828;4175.16496700655;4178.373244013423;4185.246655602021;4190.580941905846;4789.616830653539;4796.328514008042;4800.3279540864305;4802.51974802517;4806.567408933212;5718.513926316226;5718.628289161275;5721.199032135504;5721.914171287434;5727.656340619576;1431.921244331551;1457.7521821290406;1474.8820094392422;1475.963100922464;1482.2514630111725;967.9225661947028;990.4601991914279;998.0368943969105;1007.7178390050798;1008.5259927833906;4980;4997.800087996512;5001.8499445016705;5001.974990125026;5002.99940011999;5894.145348924382;5903.144044113666;5909.349971503131;5909.497692696083;5922.644641321534;4842.685225460405;4915.508449155127;4983.8504844854715;4984.40187177541;5070.6957582545165;3190.7128358447853;3209.2618697699195;3215.7748957572744;3224.725898298624;3229.3864165808423;5628.71856407178;5636.746346414421;5638.267025286768;5641.605087643908;5649.12438572022;6003.039513677791;6110.327863934964;6138.907916381258;6144.262688477412;6144.603604594212;5627.465390787868;5636.408177141341;5637.577181711388;5638.295213098363;5650.011248031578;5942.494887934574;5967.6419414835245;5971.253593300838;5971.910421343597;5981.970090149695;5796.8550786229;5812.622179558315;5821.679807610622;5832.650040997553;5833.504152147115;5496.640775244265;5581.804636837691;5600.467955544217;5627.296587926509;5628.831135065954;4060.16766562848;4081.306177949696;4084.0810817567;4084.8774536763945;4089.836406543705;5952.315483719428;5958.851028724316;5960.642361458326;5964.194833697569;5965.254343207099;5608.691521966331;5732.7706891723865;5737.08206686928;5738.856528586652;5741.741621626953;5730.684812335361;5730.71346432685;5733.283339582552;5735.684537350319;5746.569007324551;5603.859903502445;5608.635438696471;5611.607187496836;5612.887742245214;5615;5654.575906806924;5773.624714393551;5773.653580785166;5776.133579963039;5777.22007528995;5615.747291371817;5621.072523033818;5623.662580245198;5629.577781666309;5629.943700563106 05:58:56 INFO - 2015-11-23 05:58:56,318 DEBUG : BROWSER_OUTPUT: |5;yui.html;670.7048898484667;710.6931992127705;748.8577170337635;761.756238003839;795.2127393880061;10866.673999780009;11793.823092653616;11807;11817.822732659017;11819.763604727901;11954.222975506585;11954.402279886015;12037.097217708684;12049.096317776159;12067.0949678774;618.656645561713;628.6448156791421;783.6943591999125;787.8384931089141;802.7952872017627;799.0331698644646;800.5356893002045;803.445622520459;805.0379796143582;805.1948051948052;829.1666874790827;835.2649668291925;841.4194205997873;842.4650347029619;843.3295530053591;652.7128063652002;660.0099850224663;826;838.9538575378351;841.4530555139147;622.6637615687523;622.7851391270004;622.8972219583763;623.1120653069358;623.9095331176999;11021.173411994052;11105.056070234039;11134.888651113466;11154.776904461947;11164.888351116466;11085.778284434266;11126.944365278203;11265.605703800327;11330.320180789178;11438.485268162953;9087.318451116193;9117.407368521091;9343.205827504671;9412.67055653049;9466.526673666358;3053.92365190872;3109.8289594072317;3114.7508199343997;3116.7350775184136;3165.335279591289;39212.41181382253;39234.80382598098;39262.80368598167;39403;39409.40885886714;9407.247420206368;9411.952940235393;9462.432254064779;9521.809563808823;9666.323357365058;16839.41062062822;16937.745933811002;16946.745798813026;16969.745453818203;16986.405475808286;6339.524535659752;6388.297287298394;6412.67936603168;6464.482841372679;6566.606003639797;3584.4981702561663;3622.7645203061716;3646.1431563582537;3648.325059863934;3709.7217708671956;2695.3531152523647;2728.4133911209187;2728.481588498179;2733.139061195717;2742.3418379588757;473.11527443680535;491.0302153247308;495.6035171862496;547.8520799384144;567.4439049731204;588.2323567744135;592.3217915486744;618.9102580125857;619.2785405003211;626.4299487466384;8032.678692852221;8704;8840.8673869892;8887.511186884783;8939.418937769024;569.0894568690145;583.1311346094288;598.7545106506311;627.0844566932238;627.3726273726273;3634.854605815791;3784.070124236659;3802.144517483544;3833.750806197588;3841.3661745812187;47091;47968;47988.04023919502;48055;48177;43725;44293.778531107135;44516.77741611271;44576.777116114215;45391.773041135246;40216;40968.38547421791;41046.384304235464;41930.580694193275;42062.15875682469;8168.83662326762;8358.582070896553;8422.410431269753;8539.914600853912;8623.490889094508;32637.836810815796;32786;33066.834665826515;33083.834580826944;33331.666683332856;39506.60493395029;40836.1832763349;41140.38289425721;41183.58816411797;41403.79298103611;9834.21326293909;9843.704688859345;9930.801383972135;9949.353292035994;10057.748556286151;11352.091832653534;11399.544018239509;11459.31244125355;11548.538058477903;11641.767164656829;10404.68785936423;10751.6236931707;10810.24328297043;11272.436378181223;11297.887021129683;10410.791784164427;10546.894531054899;10623.946880265548;10866.511007004545;10894;10207;10437.895621043996;10513.474326283807;10514.474276286002;10626.628068017582;8958.372913895964;9077.546122693971;9106.95446522763;9351.39215950961;9357.906420935704;8761.386702930733;9082.818343633222;9229.169374756304;9428.99758675527;9646.083622055894 05:58:56 INFO - 2015-11-23 05:58:56,318 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:58:56 INFO - 2015-11-23 05:58:56,318 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:58:56 INFO - 2015-11-23 05:58:56,318 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1005 05:58:56 INFO - 2015-11-23 05:58:56,318 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:58:56 INFO - 2015-11-23 05:58:56,318 DEBUG : BROWSER_OUTPUT: __startTimestamp1448287136309__endTimestamp 05:58:56 INFO - 2015-11-23 05:58:56,318 DEBUG : BROWSER_OUTPUT: 05:58:56 INFO - 2015-11-23 05:58:56,318 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:58:56 INFO - 2015-11-23 05:58:56,318 DEBUG : BROWSER_OUTPUT: Number of tests: 6 05:58:56 INFO - 2015-11-23 05:58:56,318 DEBUG : BROWSER_OUTPUT: 05:58:56 INFO - 2015-11-23 05:58:56,319 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4629.47 Median:4749.67 stddev:474.37 (10.0%) stddev-sans-first:449.18 05:58:56 INFO - 2015-11-23 05:58:56,319 DEBUG : BROWSER_OUTPUT: Values: 2631.5 2739.2 2749.1 2751.3 2762.9 4533.7 4651.0 4669.8 4707.9 4748.3 4616.1 4627.8 4659.4 4666.3 4666.5 4298.4 4341.1 4366.7 4427.4 4431.7 4117.5 4362.3 4398.1 4428.7 4471.6 4231.7 4240.6 4296.5 4308.2 4350.3 4281.2 4334.8 4338.1 4341.5 4382.4 4076.3 4315.1 4335.7 4342.8 4382.1 4521.6 4538.4 4570.6 4652.8 4696.9 4995.1 5014.0 5014.1 5016.4 5037.9 4818.5 5019.6 5027.8 5029.8 5077.4 4622.8 4629.7 4637.5 4686.1 4755.0 5144.0 5147.3 5149.8 5149.9 5153.4 4723.0 4950.1 4953.3 4954.1 4995.9 4945.6 4947.5 4957.6 4986.9 5157.4 5022.3 5028.2 5029.7 5040.5 5073.8 4994.3 4997.6 5008.9 5012.4 5057.7 3992.4 4123.2 4126.2 4215.6 4261.9 3640.5 3699.4 3703.9 3734.5 3744.6 4332.0 4342.8 4346.7 4350.4 4382.4 4804.0 4887.7 4922.6 5064.4 5104.6 4267.2 4356.8 4359.4 4377.8 4404.1 4448.1 4450.6 4455.4 4456.6 4484.0 4603.0 4722.1 4723.1 4785.8 4796.1 4861.1 4926.7 4939.1 4959.2 4988.3 4799.4 4857.4 4863.9 4869.1 4905.6 4749.7 4868.5 4870.6 5022.3 5090.7 4980.8 5039.4 5062.9 5072.8 5107.8 4942.5 4949.2 4955.9 4957.5 4997.5 4661.5 4728.0 4776.5 4938.5 4983.8 4737.9 4792.6 4812.0 4817.0 4860.9 4882.9 4885.1 4892.4 4912.0 4925.3 4652.3 4777.9 4794.1 4796.7 4803.3 05:58:56 INFO - 2015-11-23 05:58:56,319 DEBUG : BROWSER_OUTPUT: 05:58:56 INFO - 2015-11-23 05:58:56,319 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41358.48 Median:18953.84 stddev:65547.93 (345.8%) stddev-sans-first:65660.18 05:58:56 INFO - 2015-11-23 05:58:56,320 DEBUG : BROWSER_OUTPUT: Values: 545.4 559.8 562.7 572.4 575.9 27090.7 27838.0 38644.4 39022.6 39174.4 41944.8 42226.6 42514.8 42538.1 42580.1 7020.6 7917.9 8098.0 8098.4 8100.6 7107.6 10006.9 10231.4 10236.3 10240.2 10120.3 10223.8 10229.9 10232.8 10233.1 7233.2 7405.0 10021.3 10089.5 10192.3 9585.0 9761.8 9763.5 9766.0 9769.9 38807.4 39155.6 39234.0 39261.6 39345.4 2731.9 2853.7 2877.5 2929.6 3475.5 28507.0 28594.4 28792.4 29167.4 29267.7 3402.3 3428.9 3451.4 3507.4 3545.8 237208.0 238356.0 238571.0 238782.0 239072.0 51513.2 53160.0 53166.7 55991.0 56572.7 49395.0 49451.3 59963.1 60601.7 60728.7 11304.3 11498.5 11568.5 11602.8 11611.9 8950.2 9050.5 9058.0 9074.0 9081.7 18397.9 18878.7 19133.0 19135.6 19165.9 7611.2 7860.4 7994.9 8028.8 8033.5 770.9 811.8 842.8 853.4 965.0 26427.3 26800.8 27181.9 27222.2 27276.6 880.0 885.9 926.4 944.2 952.6 12686.9 12771.3 12846.8 12873.4 13012.7 283838.0 285886.0 286055.0 286292.0 287330.0 38074.6 38647.6 43798.6 44561.8 46867.0 1142.9 1145.9 1165.5 1167.5 1185.1 23351.6 23811.8 25701.9 26805.7 27018.2 43124.0 43342.8 43442.3 43611.8 43624.8 225371.0 226815.0 226892.0 227004.0 227695.0 28518.0 28641.3 28927.4 28939.1 28939.4 39773.0 39779.6 39789.0 40267.6 40710.0 34456.3 34908.0 35054.8 35067.0 35451.5 34702.5 35052.6 35496.0 37423.0 37641.8 33149.2 34099.8 34133.7 34153.5 34167.3 28044.9 29958.5 30322.2 30580.5 30790.2 23266.0 24237.9 24639.0 24939.3 25817.6 05:58:56 INFO - 2015-11-23 05:58:56,320 DEBUG : BROWSER_OUTPUT: 05:58:56 INFO - 2015-11-23 05:58:56,320 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26711.04 Median:4477.90 stddev:85326.93 (1905.5%) stddev-sans-first:85543.31 05:58:56 INFO - 2015-11-23 05:58:56,320 DEBUG : BROWSER_OUTPUT: Values: 337.2 337.8 341.5 342.4 343.5 12545.5 12883.5 14914.0 15098.0 16422.0 14271.6 14635.7 14821.1 14828.6 15075.1 3390.8 4473.9 4595.8 5019.9 5022.5 4993.4 5018.6 5022.7 5032.2 5034.1 4839.4 4944.8 4955.6 4971.4 5002.2 5042.4 5052.4 5052.9 5053.8 5060.7 4481.9 4482.8 4562.1 4563.8 4574.2 11772.1 11844.3 11848.3 11865.8 15607.6 1827.0 1855.9 1873.9 1917.0 1982.5 9100.5 9347.1 9755.9 12557.1 13161.5 1734.8 1761.3 1762.5 1782.5 1814.5 45561.3 45859.8 46395.8 46568.3 51999.5 9710.5 9879.0 9884.1 9909.4 9943.7 10758.1 10917.9 12309.6 12330.5 21720.2 7727.6 7832.0 7868.7 7874.0 7890.8 5740.8 5793.8 6397.7 6442.6 6448.1 7410.8 7600.3 7633.5 7645.0 7785.3 2872.8 2963.6 2972.9 2973.7 2990.4 773.9 860.6 890.3 902.5 905.2 15314.4 15516.1 15756.7 15964.4 15986.0 771.0 794.2 806.7 840.7 871.9 7003.8 8809.8 8843.8 8961.1 9463.0 506832.0 510147.0 529125.0 535232.0 536066.0 67078.3 67385.0 67915.7 68171.0 69910.7 1001.0 1022.8 1064.0 1082.3 1104.6 13510.4 13609.9 13665.0 13763.4 14051.3 29555.3 29767.4 29815.9 31405.2 32540.7 35546.5 37220.6 37385.3 39293.4 40230.6 8357.8 8427.2 8654.0 8735.5 8766.3 15248.2 15249.2 15505.9 15584.8 15642.1 13288.0 13436.2 13470.3 13703.3 14223.6 13463.5 13854.0 14036.8 14098.3 14317.5 13981.8 14178.9 14188.9 14412.7 14704.5 8490.9 8743.5 8833.6 8867.6 9032.9 9069.0 9147.0 9151.3 10759.7 12602.4 05:58:56 INFO - 2015-11-23 05:58:56,321 DEBUG : BROWSER_OUTPUT: 05:58:56 INFO - 2015-11-23 05:58:56,321 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4647.08 Median:6036.71 stddev:2313.40 (38.3%) stddev-sans-first:2305.78 05:58:56 INFO - 2015-11-23 05:58:56,321 DEBUG : BROWSER_OUTPUT: Values: 1248.5 1626.4 1664.9 1682.0 1686.9 5816.5 6186.3 6376.3 6389.6 6389.8 6535.1 6565.6 6620.7 6645.4 6649.4 1744.6 1771.1 1775.5 2030.9 2050.3 1787.0 1788.8 2020.0 2041.9 2050.5 1986.1 2015.1 2024.2 2026.4 2028.3 2052.1 2077.6 2080.8 2082.3 2082.7 2026.6 2035.0 2061.8 2064.0 2069.4 6592.0 6644.2 6646.2 6652.1 6652.7 3985.2 4049.4 4050.5 4056.6 4057.0 2681.9 2720.8 2733.6 2748.6 2759.7 863.8 864.6 876.4 878.8 896.7 8335.2 8389.2 8404.3 8407.9 8416.3 3677.4 3717.4 3796.8 3797.5 3828.4 7417.7 7471.0 7483.4 7492.9 7495.5 4061.5 4086.2 4089.9 4124.0 4129.9 3725.5 3738.9 3755.7 3756.9 3757.4 2853.6 3253.3 3298.0 3339.3 3343.9 937.7 1010.2 1017.5 1028.5 1041.1 777.6 818.2 822.2 823.0 904.4 6074.7 6135.0 6186.5 6194.2 6196.1 998.9 1000.8 1008.1 1019.3 1028.0 4977.4 5054.2 5056.2 5058.8 5061.2 7600.5 7655.0 7745.1 7835.4 7837.7 7610.3 7664.1 7665.5 7694.0 7734.3 6067.5 6127.5 6143.2 6184.2 6197.8 6212.0 6247.9 6248.6 6312.6 6314.8 6660.6 7011.0 7037.9 7098.3 7160.7 7168.4 7183.6 7206.0 7299.0 7382.9 5963.6 6037.6 6039.6 6050.4 6052.1 5701.2 6484.3 6519.6 6534.1 6540.1 5604.6 5734.6 6042.3 6095.8 6136.1 5896.8 5974.7 6035.8 6050.9 6106.8 6050.0 6063.7 6091.8 6099.2 6099.8 5690.1 5723.4 5734.7 5739.9 5745.1 5503.9 5584.3 5815.4 5836.0 5846.9 05:58:56 INFO - 2015-11-23 05:58:56,321 DEBUG : BROWSER_OUTPUT: 05:58:56 INFO - 2015-11-23 05:58:56,321 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4734.22 Median:5300.63 stddev:1392.47 (26.3%) stddev-sans-first:1356.21 05:58:56 INFO - 2015-11-23 05:58:56,323 DEBUG : BROWSER_OUTPUT: Values: 310.8 318.7 320.2 321.7 322.5 5298.7 5360.5 5387.8 5388.9 5413.9 5069.9 5097.6 5203.1 5302.5 5342.4 4167.1 4181.1 4206.4 4222.2 4229.5 3986.9 4223.0 4224.6 4227.8 4237.8 4028.2 4057.6 4173.1 4178.9 4193.9 4167.4 4171.4 4173.8 4175.9 4177.7 3670.8 3672.3 3682.0 3682.5 3683.8 5127.9 5184.0 5197.2 5207.4 5208.6 4636.9 4769.7 4790.1 4815.7 4816.0 5702.5 5706.2 5710.5 5713.3 5714.5 3983.5 3992.9 3995.2 3996.0 3996.5 5887.6 5972.7 5991.3 5994.6 6001.4 3966.6 4110.0 4118.6 4121.5 4132.4 4167.8 4175.2 4178.4 4185.2 4190.6 4789.6 4796.3 4800.3 4802.5 4806.6 5718.5 5718.6 5721.2 5721.9 5727.7 1431.9 1457.8 1474.9 1476.0 1482.3 967.9 990.5 998.0 1007.7 1008.5 4980.0 4997.8 5001.8 5002.0 5003.0 5894.1 5903.1 5909.3 5909.5 5922.6 4842.7 4915.5 4983.9 4984.4 5070.7 3190.7 3209.3 3215.8 3224.7 3229.4 5628.7 5636.7 5638.3 5641.6 5649.1 6003.0 6110.3 6138.9 6144.3 6144.6 5627.5 5636.4 5637.6 5638.3 5650.0 5942.5 5967.6 5971.3 5971.9 5982.0 5796.9 5812.6 5821.7 5832.7 5833.5 5496.6 5581.8 5600.5 5627.3 5628.8 4060.2 4081.3 4084.1 4084.9 4089.8 5952.3 5958.9 5960.6 5964.2 5965.3 5608.7 5732.8 5737.1 5738.9 5741.7 5730.7 5730.7 5733.3 5735.7 5746.6 5603.9 5608.6 5611.6 5612.9 5615.0 5654.6 5773.6 5773.7 5776.1 5777.2 5615.7 5621.1 5623.7 5629.6 5629.9 05:58:56 INFO - 2015-11-23 05:58:56,323 DEBUG : BROWSER_OUTPUT: 05:58:56 INFO - 2015-11-23 05:58:56,323 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12312.96 Median:46241.39 stddev:13767.16 (29.8%) stddev-sans-first:13778.01 05:58:56 INFO - 2015-11-23 05:58:56,323 DEBUG : BROWSER_OUTPUT: Values: 670.7 710.7 748.9 761.8 795.2 10866.7 11793.8 11807.0 11817.8 11819.8 11954.2 11954.4 12037.1 12049.1 12067.1 618.7 628.6 783.7 787.8 802.8 799.0 800.5 803.4 805.0 805.2 829.2 835.3 841.4 842.5 843.3 652.7 660.0 826.0 839.0 841.5 622.7 622.8 622.9 623.1 623.9 11021.2 11105.1 11134.9 11154.8 11164.9 11085.8 11126.9 11265.6 11330.3 11438.5 9087.3 9117.4 9343.2 9412.7 9466.5 3053.9 3109.8 3114.8 3116.7 3165.3 39212.4 39234.8 39262.8 39403.0 39409.4 9407.2 9412.0 9462.4 9521.8 9666.3 16839.4 16937.7 16946.7 16969.7 16986.4 6339.5 6388.3 6412.7 6464.5 6566.6 3584.5 3622.8 3646.1 3648.3 3709.7 2695.4 2728.4 2728.5 2733.1 2742.3 473.1 491.0 495.6 547.9 567.4 588.2 592.3 618.9 619.3 626.4 8032.7 8704.0 8840.9 8887.5 8939.4 569.1 583.1 598.8 627.1 627.4 3634.9 3784.1 3802.1 3833.8 3841.4 47091.0 47968.0 47988.0 48055.0 48177.0 43725.0 44293.8 44516.8 44576.8 45391.8 40216.0 40968.4 41046.4 41930.6 42062.2 8168.8 8358.6 8422.4 8539.9 8623.5 32637.8 32786.0 33066.8 33083.8 33331.7 39506.6 40836.2 41140.4 41183.6 41403.8 9834.2 9843.7 9930.8 9949.4 10057.7 11352.1 11399.5 11459.3 11548.5 11641.8 10404.7 10751.6 10810.2 11272.4 11297.9 10410.8 10546.9 10623.9 10866.5 10894.0 10207.0 10437.9 10513.5 10514.5 10626.6 8958.4 9077.5 9107.0 9351.4 9357.9 8761.4 9082.8 9229.2 9429.0 9646.1 05:58:56 INFO - 2015-11-23 05:58:56,323 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:58:56 INFO - 2015-11-23 05:58:56,323 DEBUG : BROWSER_OUTPUT: 05:58:57 INFO - 2015-11-23 05:58:57,001 INFO : Browser exited with error code: 0 05:58:57 INFO - 2015-11-23 05:58:57,017 INFO : Completed test dromaeo_css (00:18:38) 05:58:57 INFO - 2015-11-23 05:58:57,018 INFO : Starting test kraken 05:58:57 INFO - 2015-11-23 05:58:57,018 DEBUG : operating with platform_type : linux_ 05:58:57 INFO - 2015-11-23 05:58:57,018 INFO : Initialising browser for kraken test... 05:58:57 INFO - 2015-11-23 05:58:57,024 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpemt_tQ/profile http://localhost:39850/getInfo.html 05:59:01 INFO - 2015-11-23 05:59:01,344 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:59:01 INFO - 2015-11-23 05:59:01,344 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:59:01 INFO - 2015-11-23 05:59:01,344 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:59:01 INFO - 2015-11-23 05:59:01,345 DEBUG : BROWSER_OUTPUT: __metrics 05:59:01 INFO - 2015-11-23 05:59:01,501 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:59:02 INFO - 2015-11-23 05:59:02,844 INFO : Browser initialized. 05:59:02 INFO - 2015-11-23 05:59:02,845 INFO : Running cycle 1/1 for kraken test... 05:59:02 INFO - 2015-11-23 05:59:02,845 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpemt_tQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:59:14 INFO - 2015-11-23 05:59:14,703 DEBUG : BROWSER_OUTPUT: RSS: Main: 140238848 05:59:14 INFO - 2015-11-23 05:59:14,704 DEBUG : BROWSER_OUTPUT: 05:59:17 INFO - 2015-11-23 05:59:17,329 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39850/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39850/tests/kraken/driver.html?testName=audio-beat-detection) 05:59:17 INFO - 2015-11-23 05:59:17,915 DEBUG : BROWSER_OUTPUT: RSS: Main: 175591424 05:59:17 INFO - 2015-11-23 05:59:17,915 DEBUG : BROWSER_OUTPUT: 05:59:20 INFO - 2015-11-23 05:59:20,620 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39850/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39850/tests/kraken/driver.html?testName=audio-dft) 05:59:21 INFO - 2015-11-23 05:59:21,194 DEBUG : BROWSER_OUTPUT: RSS: Main: 166305792 05:59:21 INFO - 2015-11-23 05:59:21,194 DEBUG : BROWSER_OUTPUT: 05:59:24 INFO - 2015-11-23 05:59:24,219 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39850/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39850/tests/kraken/driver.html?testName=audio-fft) 05:59:24 INFO - 2015-11-23 05:59:24,781 DEBUG : BROWSER_OUTPUT: RSS: Main: 152076288 05:59:24 INFO - 2015-11-23 05:59:24,781 DEBUG : BROWSER_OUTPUT: 05:59:26 INFO - 2015-11-23 05:59:26,822 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39850/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39850/tests/kraken/driver.html?testName=audio-oscillator) 05:59:27 INFO - 2015-11-23 05:59:27,391 DEBUG : BROWSER_OUTPUT: RSS: Main: 153927680 05:59:27 INFO - 2015-11-23 05:59:27,391 DEBUG : BROWSER_OUTPUT: 05:59:29 INFO - 2015-11-23 05:59:29,599 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39850/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39850/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:59:30 INFO - 2015-11-23 05:59:30,165 DEBUG : BROWSER_OUTPUT: RSS: Main: 154820608 05:59:30 INFO - 2015-11-23 05:59:30,165 DEBUG : BROWSER_OUTPUT: 05:59:33 INFO - 2015-11-23 05:59:33,136 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39850/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39850/tests/kraken/driver.html?testName=imaging-darkroom) 05:59:33 INFO - 2015-11-23 05:59:33,717 DEBUG : BROWSER_OUTPUT: RSS: Main: 156028928 05:59:33 INFO - 2015-11-23 05:59:33,717 DEBUG : BROWSER_OUTPUT: 05:59:37 INFO - 2015-11-23 05:59:37,153 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39850/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39850/tests/kraken/driver.html?testName=imaging-desaturate) 05:59:37 INFO - 2015-11-23 05:59:37,734 DEBUG : BROWSER_OUTPUT: RSS: Main: 157024256 05:59:37 INFO - 2015-11-23 05:59:37,734 DEBUG : BROWSER_OUTPUT: 05:59:40 INFO - 2015-11-23 05:59:40,573 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39850/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39850/tests/kraken/driver.html?testName=json-parse-financial) 05:59:41 INFO - 2015-11-23 05:59:41,154 DEBUG : BROWSER_OUTPUT: RSS: Main: 155832320 05:59:41 INFO - 2015-11-23 05:59:41,154 DEBUG : BROWSER_OUTPUT: 05:59:42 INFO - 2015-11-23 05:59:42,905 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39850/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39850/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:59:43 INFO - 2015-11-23 05:59:43,470 DEBUG : BROWSER_OUTPUT: RSS: Main: 162738176 05:59:43 INFO - 2015-11-23 05:59:43,471 DEBUG : BROWSER_OUTPUT: 05:59:45 INFO - 2015-11-23 05:59:45,382 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39850/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39850/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:59:45 INFO - 2015-11-23 05:59:45,968 DEBUG : BROWSER_OUTPUT: RSS: Main: 164499456 05:59:45 INFO - 2015-11-23 05:59:45,968 DEBUG : BROWSER_OUTPUT: 05:59:48 INFO - 2015-11-23 05:59:48,081 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39850/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39850/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:59:48 INFO - 2015-11-23 05:59:48,654 DEBUG : BROWSER_OUTPUT: RSS: Main: 169353216 05:59:48 INFO - 2015-11-23 05:59:48,654 DEBUG : BROWSER_OUTPUT: 05:59:51 INFO - 2015-11-23 05:59:51,183 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39850/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39850/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:59:51 INFO - 2015-11-23 05:59:51,769 DEBUG : BROWSER_OUTPUT: RSS: Main: 177631232 05:59:51 INFO - 2015-11-23 05:59:51,769 DEBUG : BROWSER_OUTPUT: 05:59:54 INFO - 2015-11-23 05:59:54,366 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39850/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39850/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:59:54 INFO - 2015-11-23 05:59:54,940 DEBUG : BROWSER_OUTPUT: RSS: Main: 176918528 05:59:54 INFO - 2015-11-23 05:59:54,940 DEBUG : BROWSER_OUTPUT: 05:59:56 INFO - 2015-11-23 05:59:56,692 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39850/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39850/tests/kraken/driver.html?testName=ai-astar) 05:59:56 INFO - 2015-11-23 05:59:56,942 DEBUG : BROWSER_OUTPUT: RSS: Main: 235945984 05:59:56 INFO - 2015-11-23 05:59:56,942 DEBUG : BROWSER_OUTPUT: 05:59:56 INFO - 2015-11-23 05:59:56,945 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:59:56 INFO - 2015-11-23 05:59:56,946 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:59:56 INFO - 2015-11-23 05:59:56,946 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:59:56 INFO - 2015-11-23 05:59:56,946 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:59:56 INFO - 2015-11-23 05:59:56,946 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;115;107;112;114;120;104;113;104;114 05:59:56 INFO - 2015-11-23 05:59:56,946 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;157;131;150;166;132;153;158;131;167;133 05:59:56 INFO - 2015-11-23 05:59:56,947 DEBUG : BROWSER_OUTPUT: |2;audio-dft;164;162;161;161;161;161;161;162;163;164 05:59:56 INFO - 2015-11-23 05:59:56,947 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;73;83;91;77;74;74;107;92;73 05:59:56 INFO - 2015-11-23 05:59:56,947 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;91;129;92;91;91;145;91;92;126 05:59:56 INFO - 2015-11-23 05:59:56,947 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;109;110;109;109;109;110;109;109 05:59:56 INFO - 2015-11-23 05:59:56,947 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;147;148;147;147;146;146;146;146;146 05:59:56 INFO - 2015-11-23 05:59:56,948 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;96;96;95;95;95;95;96;95 05:59:56 INFO - 2015-11-23 05:59:56,948 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;71;70;69;70;69;70;71;78;67;69 05:59:56 INFO - 2015-11-23 05:59:56,948 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;69;69;70;69;69;68;68;69 05:59:56 INFO - 2015-11-23 05:59:56,948 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;84;84;82;82;82;84;83;85;81 05:59:56 INFO - 2015-11-23 05:59:56,949 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;121;118;129;125;123;119;121;125;120;127 05:59:56 INFO - 2015-11-23 05:59:56,949 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;139;157;143;141;166;142;137;154;154;142 05:59:56 INFO - 2015-11-23 05:59:56,949 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;69;68;72;69;71;70;79;69;69 05:59:56 INFO - 2015-11-23 05:59:56,949 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:59:56 INFO - 2015-11-23 05:59:56,949 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:59:56 INFO - 2015-11-23 05:59:56,949 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,954 05:59:56 INFO - 2015-11-23 05:59:56,949 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:59:56 INFO - 2015-11-23 05:59:56,949 DEBUG : BROWSER_OUTPUT: __startTimestamp1448287196943__endTimestamp 05:59:56 INFO - 2015-11-23 05:59:56,950 DEBUG : BROWSER_OUTPUT: 05:59:56 INFO - 2015-11-23 05:59:56,953 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:59:56 INFO - 2015-11-23 05:59:56,953 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:59:56 INFO - 2015-11-23 05:59:56,953 DEBUG : BROWSER_OUTPUT: 05:59:56 INFO - 2015-11-23 05:59:56,953 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.60 Median:113.50 stddev:5.10 (4.5%) stddev-sans-first:5.39 05:59:56 INFO - 2015-11-23 05:59:56,953 DEBUG : BROWSER_OUTPUT: Values: 113.0 115.0 107.0 112.0 114.0 120.0 104.0 113.0 104.0 114.0 05:59:56 INFO - 2015-11-23 05:59:56,953 DEBUG : BROWSER_OUTPUT: 05:59:56 INFO - 2015-11-23 05:59:56,954 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:147.80 Median:155.00 stddev:14.73 (9.5%) stddev-sans-first:15.25 05:59:56 INFO - 2015-11-23 05:59:56,954 DEBUG : BROWSER_OUTPUT: Values: 157.0 131.0 150.0 166.0 132.0 153.0 158.0 131.0 167.0 133.0 05:59:56 INFO - 2015-11-23 05:59:56,954 DEBUG : BROWSER_OUTPUT: 05:59:56 INFO - 2015-11-23 05:59:56,954 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:1.25 (0.8%) stddev-sans-first:1.09 05:59:56 INFO - 2015-11-23 05:59:56,954 DEBUG : BROWSER_OUTPUT: Values: 164.0 162.0 161.0 161.0 161.0 161.0 161.0 162.0 163.0 164.0 05:59:56 INFO - 2015-11-23 05:59:56,954 DEBUG : BROWSER_OUTPUT: 05:59:56 INFO - 2015-11-23 05:59:56,954 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.60 Median:75.50 stddev:11.64 (15.4%) stddev-sans-first:11.82 05:59:56 INFO - 2015-11-23 05:59:56,954 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 83.0 91.0 77.0 74.0 74.0 107.0 92.0 73.0 05:59:56 INFO - 2015-11-23 05:59:56,954 DEBUG : BROWSER_OUTPUT: 05:59:56 INFO - 2015-11-23 05:59:56,954 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.00 Median:91.00 stddev:20.81 (22.9%) stddev-sans-first:21.62 05:59:56 INFO - 2015-11-23 05:59:56,955 DEBUG : BROWSER_OUTPUT: Values: 92.0 91.0 129.0 92.0 91.0 91.0 145.0 91.0 92.0 126.0 05:59:56 INFO - 2015-11-23 05:59:56,955 DEBUG : BROWSER_OUTPUT: 05:59:56 INFO - 2015-11-23 05:59:56,955 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 05:59:56 INFO - 2015-11-23 05:59:56,955 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 109.0 110.0 109.0 109.0 109.0 110.0 109.0 109.0 05:59:56 INFO - 2015-11-23 05:59:56,955 DEBUG : BROWSER_OUTPUT: 05:59:56 INFO - 2015-11-23 05:59:56,955 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.73 05:59:56 INFO - 2015-11-23 05:59:56,955 DEBUG : BROWSER_OUTPUT: Values: 148.0 147.0 148.0 147.0 147.0 146.0 146.0 146.0 146.0 146.0 05:59:56 INFO - 2015-11-23 05:59:56,955 DEBUG : BROWSER_OUTPUT: 05:59:56 INFO - 2015-11-23 05:59:56,955 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 05:59:56 INFO - 2015-11-23 05:59:56,955 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 96.0 96.0 95.0 95.0 95.0 95.0 96.0 95.0 05:59:56 INFO - 2015-11-23 05:59:56,956 DEBUG : BROWSER_OUTPUT: 05:59:56 INFO - 2015-11-23 05:59:56,956 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:70.40 Median:70.00 stddev:2.91 (4.2%) stddev-sans-first:3.08 05:59:56 INFO - 2015-11-23 05:59:56,956 DEBUG : BROWSER_OUTPUT: Values: 71.0 70.0 69.0 70.0 69.0 70.0 71.0 78.0 67.0 69.0 05:59:56 INFO - 2015-11-23 05:59:56,956 DEBUG : BROWSER_OUTPUT: 05:59:56 INFO - 2015-11-23 05:59:56,956 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:69.00 stddev:0.57 (0.8%) stddev-sans-first:0.60 05:59:56 INFO - 2015-11-23 05:59:56,956 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 69.0 69.0 70.0 69.0 69.0 68.0 68.0 69.0 05:59:56 INFO - 2015-11-23 05:59:56,956 DEBUG : BROWSER_OUTPUT: 05:59:56 INFO - 2015-11-23 05:59:56,956 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:83.50 stddev:1.29 (1.5%) stddev-sans-first:1.32 05:59:56 INFO - 2015-11-23 05:59:56,956 DEBUG : BROWSER_OUTPUT: Values: 82.0 84.0 84.0 82.0 82.0 82.0 84.0 83.0 85.0 81.0 05:59:56 INFO - 2015-11-23 05:59:56,957 DEBUG : BROWSER_OUTPUT: 05:59:56 INFO - 2015-11-23 05:59:56,957 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:122.80 Median:124.00 stddev:3.61 (2.9%) stddev-sans-first:3.77 05:59:56 INFO - 2015-11-23 05:59:56,957 DEBUG : BROWSER_OUTPUT: Values: 121.0 118.0 129.0 125.0 123.0 119.0 121.0 125.0 120.0 127.0 05:59:56 INFO - 2015-11-23 05:59:56,957 DEBUG : BROWSER_OUTPUT: 05:59:56 INFO - 2015-11-23 05:59:56,957 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.50 Median:148.50 stddev:9.56 (6.4%) stddev-sans-first:9.63 05:59:56 INFO - 2015-11-23 05:59:56,957 DEBUG : BROWSER_OUTPUT: Values: 139.0 157.0 143.0 141.0 166.0 142.0 137.0 154.0 154.0 142.0 05:59:56 INFO - 2015-11-23 05:59:56,957 DEBUG : BROWSER_OUTPUT: 05:59:56 INFO - 2015-11-23 05:59:56,957 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.50 Median:69.50 stddev:3.21 (4.6%) stddev-sans-first:3.35 05:59:56 INFO - 2015-11-23 05:59:56,957 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 68.0 72.0 69.0 71.0 70.0 79.0 69.0 69.0 05:59:56 INFO - 2015-11-23 05:59:56,958 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:59:56 INFO - 2015-11-23 05:59:56,958 DEBUG : BROWSER_OUTPUT: 05:59:57 INFO - 2015-11-23 05:59:57,861 INFO : Browser exited with error code: 0 05:59:57 INFO - 2015-11-23 05:59:57,912 INFO : Completed test kraken (00:01:00) 05:59:57 INFO - 2015-11-23 05:59:57,912 INFO : Starting test v8_7 05:59:57 INFO - 2015-11-23 05:59:57,912 DEBUG : operating with platform_type : linux_ 05:59:57 INFO - 2015-11-23 05:59:57,913 INFO : Initialising browser for v8_7 test... 05:59:57 INFO - 2015-11-23 05:59:57,919 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFcR0Ob/profile http://localhost:39850/getInfo.html 06:00:02 INFO - 2015-11-23 06:00:02,216 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:00:02 INFO - 2015-11-23 06:00:02,216 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:00:02 INFO - 2015-11-23 06:00:02,216 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:00:02 INFO - 2015-11-23 06:00:02,216 DEBUG : BROWSER_OUTPUT: __metrics 06:00:02 INFO - 2015-11-23 06:00:02,358 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:00:03 INFO - 2015-11-23 06:00:03,640 INFO : Browser initialized. 06:00:03 INFO - 2015-11-23 06:00:03,641 INFO : Running cycle 1/1 for v8_7 test... 06:00:03 INFO - 2015-11-23 06:00:03,641 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFcR0Ob/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:00:15 INFO - 2015-11-23 06:00:15,575 DEBUG : BROWSER_OUTPUT: RSS: Main: 141643776 06:00:15 INFO - 2015-11-23 06:00:15,575 DEBUG : BROWSER_OUTPUT: 06:00:37 INFO - 2015-11-23 06:00:37,085 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39850/tests/v8_7/run.html (next: http://localhost:39850/tests/v8_7/run.html) 06:00:37 INFO - 2015-11-23 06:00:37,335 DEBUG : BROWSER_OUTPUT: RSS: Main: 450441216 06:00:37 INFO - 2015-11-23 06:00:37,335 DEBUG : BROWSER_OUTPUT: 06:00:37 INFO - 2015-11-23 06:00:37,336 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:00:37 INFO - 2015-11-23 06:00:37,336 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:00:37 INFO - 2015-11-23 06:00:37,336 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:00:37 INFO - 2015-11-23 06:00:37,336 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:00:37 INFO - 2015-11-23 06:00:37,336 DEBUG : BROWSER_OUTPUT: |0;Richards;163.3986928104575 06:00:37 INFO - 2015-11-23 06:00:37,336 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;193.16206297083252 06:00:37 INFO - 2015-11-23 06:00:37,336 DEBUG : BROWSER_OUTPUT: |2;Encrypt;282.7254735651682 06:00:37 INFO - 2015-11-23 06:00:37,337 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5035.175879396985 06:00:37 INFO - 2015-11-23 06:00:37,337 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2176.086956521739 06:00:37 INFO - 2015-11-23 06:00:37,337 DEBUG : BROWSER_OUTPUT: |5;Earley;793.6507936507936 06:00:37 INFO - 2015-11-23 06:00:37,337 DEBUG : BROWSER_OUTPUT: |6;Boyer;12304.878048780487 06:00:37 INFO - 2015-11-23 06:00:37,337 DEBUG : BROWSER_OUTPUT: |7;RegExp;26736.842105263157 06:00:37 INFO - 2015-11-23 06:00:37,338 DEBUG : BROWSER_OUTPUT: |8;Splay;598.4578884934757 06:00:37 INFO - 2015-11-23 06:00:37,338 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4845.410628019324 06:00:37 INFO - 2015-11-23 06:00:37,338 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:00:37 INFO - 2015-11-23 06:00:37,338 DEBUG : BROWSER_OUTPUT: __startTimestamp1448287237334__endTimestamp 06:00:37 INFO - 2015-11-23 06:00:37,338 DEBUG : BROWSER_OUTPUT: 06:00:37 INFO - 2015-11-23 06:00:37,339 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:00:37 INFO - 2015-11-23 06:00:37,339 DEBUG : BROWSER_OUTPUT: Number of tests: 10 06:00:37 INFO - 2015-11-23 06:00:37,339 DEBUG : BROWSER_OUTPUT: 06:00:37 INFO - 2015-11-23 06:00:37,339 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.40 Median:163.40 stddev:0.00 (0.0%) 06:00:37 INFO - 2015-11-23 06:00:37,339 DEBUG : BROWSER_OUTPUT: Values: 163.4 06:00:37 INFO - 2015-11-23 06:00:37,339 DEBUG : BROWSER_OUTPUT: 06:00:37 INFO - 2015-11-23 06:00:37,340 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:193.16 Median:193.16 stddev:0.00 (0.0%) 06:00:37 INFO - 2015-11-23 06:00:37,340 DEBUG : BROWSER_OUTPUT: Values: 193.2 06:00:37 INFO - 2015-11-23 06:00:37,340 DEBUG : BROWSER_OUTPUT: 06:00:37 INFO - 2015-11-23 06:00:37,341 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:282.73 Median:282.73 stddev:0.00 (0.0%) 06:00:37 INFO - 2015-11-23 06:00:37,341 DEBUG : BROWSER_OUTPUT: Values: 282.7 06:00:37 INFO - 2015-11-23 06:00:37,341 DEBUG : BROWSER_OUTPUT: 06:00:37 INFO - 2015-11-23 06:00:37,341 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5035.18 Median:5035.18 stddev:0.00 (0.0%) 06:00:37 INFO - 2015-11-23 06:00:37,341 DEBUG : BROWSER_OUTPUT: Values: 5035.2 06:00:37 INFO - 2015-11-23 06:00:37,341 DEBUG : BROWSER_OUTPUT: 06:00:37 INFO - 2015-11-23 06:00:37,342 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2176.09 Median:2176.09 stddev:0.00 (0.0%) 06:00:37 INFO - 2015-11-23 06:00:37,342 DEBUG : BROWSER_OUTPUT: Values: 2176.1 06:00:37 INFO - 2015-11-23 06:00:37,342 DEBUG : BROWSER_OUTPUT: 06:00:37 INFO - 2015-11-23 06:00:37,342 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:793.65 Median:793.65 stddev:0.00 (0.0%) 06:00:37 INFO - 2015-11-23 06:00:37,342 DEBUG : BROWSER_OUTPUT: Values: 793.7 06:00:37 INFO - 2015-11-23 06:00:37,342 DEBUG : BROWSER_OUTPUT: 06:00:37 INFO - 2015-11-23 06:00:37,342 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12304.88 Median:12304.88 stddev:0.00 (0.0%) 06:00:37 INFO - 2015-11-23 06:00:37,342 DEBUG : BROWSER_OUTPUT: Values: 12304.9 06:00:37 INFO - 2015-11-23 06:00:37,342 DEBUG : BROWSER_OUTPUT: 06:00:37 INFO - 2015-11-23 06:00:37,342 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26736.84 Median:26736.84 stddev:0.00 (0.0%) 06:00:37 INFO - 2015-11-23 06:00:37,342 DEBUG : BROWSER_OUTPUT: Values: 26736.8 06:00:37 INFO - 2015-11-23 06:00:37,342 DEBUG : BROWSER_OUTPUT: 06:00:37 INFO - 2015-11-23 06:00:37,342 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:598.46 Median:598.46 stddev:0.00 (0.0%) 06:00:37 INFO - 2015-11-23 06:00:37,342 DEBUG : BROWSER_OUTPUT: Values: 598.5 06:00:37 INFO - 2015-11-23 06:00:37,342 DEBUG : BROWSER_OUTPUT: 06:00:37 INFO - 2015-11-23 06:00:37,342 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 06:00:37 INFO - 2015-11-23 06:00:37,343 DEBUG : BROWSER_OUTPUT: Values: 4845.4 06:00:37 INFO - 2015-11-23 06:00:37,343 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:00:37 INFO - 2015-11-23 06:00:37,343 DEBUG : BROWSER_OUTPUT: 06:00:38 INFO - 2015-11-23 06:00:38,289 INFO : Browser exited with error code: 0 06:00:38 INFO - 2015-11-23 06:00:38,304 INFO : Completed test v8_7 (00:00:40) 06:00:38 INFO - 2015-11-23 06:00:38,789 INFO : Completed test suite (00:20:20) 06:00:38 INFO - 2015-11-23 06:00:38,789 DEBUG : Working with test: dromaeo_css 06:00:38 INFO - 2015-11-23 06:00:38,789 DEBUG : Generating results file: dromaeo_css 06:00:38 INFO - 2015-11-23 06:00:38,790 DEBUG : Working with test: kraken 06:00:38 INFO - 2015-11-23 06:00:38,790 DEBUG : Generating results file: kraken 06:00:38 INFO - 2015-11-23 06:00:38,791 INFO : javascript benchmark 06:00:38 INFO - 2015-11-23 06:00:38,791 DEBUG : Working with test: v8_7 06:00:38 INFO - 2015-11-23 06:00:38,791 DEBUG : Generating results file: v8_7 06:00:38 INFO - 2015-11-23 06:00:38,791 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:00:38 INFO - 2015-11-23 06:00:38,855 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 06:00:38 INFO - 2015-11-23 06:00:38,855 DEBUG : process_Request line: dromaeo_css 6293.70 graph.html#tests=[[72,132,35]] 06:00:38 INFO - 2015-11-23 06:00:38,855 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:00:38 INFO - 2015-11-23 06:00:38,887 DEBUG : process_Request line: kraken 1521.40 graph.html#tests=[[232,132,35]] 06:00:38 INFO - 2015-11-23 06:00:38,887 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:00:38 INFO - 2015-11-23 06:00:38,922 DEBUG : process_Request line: v8_7 19609.08 graph.html#tests=[[230,132,35]] 06:00:38 INFO - 2015-11-23 06:00:38,923 INFO : javascript benchmark 06:00:38 INFO - 2015-11-23 06:00:38,927 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2631.4737052589485, 2739.233014755869, 2749.1340227828246, 2751.29841890318, 2762.944741105179, 4533.682642215038, 4650.953490465095, 4669.836555720551, 4707.929381059283, 4748.26401907704, 4616.122936642036, 4627.814887404508, 4659.4175728034, 4666.300054991753, 4666.486686464495, 4298.441202643652, 4341.088371442001, 4366.650667946573, 4427.424434823469, 4431.667624928127, 4117.505899292089, 4362.258416069276, 4398.142362239365, 4428.689991700582, 4471.575200355977, 4231.682623803227, 4240.597143271384, 4296.548862369469, 4308.224519586473, 4350.260455722535, 4281.165172791307, 4334.826606935719, 4338.067315527177, 4341.5441378655105, 4382.408374869416, 4076.266272071026, 4315.050688848449, 4335.6965012449145, 4342.848000319974, 4382.101669157815, 4521.570450807201, 4538.364628951949, 4570.588647021751, 4652.767361631905, 4696.882577935545, 4995.125852975715, 5014.047331007134, 5014.097462456756, 5016.372953380827, 5037.949620503785, 4818.542238487373, 5019.623528235397, 5027.84916452507, 5029.798808047673, 5077.390713114413, 4622.768861556942, 4629.65277604181, 4637.489876113625, 4686.086213188463, 4754.976225118921, 5144.0, 5147.279380886679, 5149.76826042829, 5149.871253218699, 5153.3558305211845, 4723.0, 4950.059488697136, 4953.281774142802, 4954.058728841508, 4995.925061124086, 4945.629077819178, 4947.480514545993, 4957.553820156131, 4986.90026199474, 5157.406898206679, 5022.296878437021, 5028.195488721787, 5029.698218106925, 5040.49595040493, 5073.771680274396, 4994.275830004629, 4997.600191984705, 5008.949910500921, 5012.373453318335, 5057.671251368723, 3992.441058251847, 4123.195976784558, 4126.195391898611, 4215.59951804578, 4261.872143835628, 3640.4903313536124, 3699.408094704834, 3703.9074023149637, 3734.4958430612064, 3744.588095309514, 4332.0469496710675, 4342.804573794187, 4346.739195648208, 4350.434443522322, 4382.386465894777, 4803.975980120077, 4887.657863949489, 4922.581580565692, 5064.442911279756, 5104.617153713486, 4267.189234045583, 4356.782160891943, 4359.367891655692, 4377.802998865059, 4404.075144219686, 4448.132614140276, 4450.621697155713, 4455.443069616298, 4456.554344565518, 4484.035932274576, 4602.976985115053, 4722.126406614787, 4723.078999595046, 4785.832495862628, 4796.1127191468995, 4861.052094841472, 4926.679765815211, 4939.135651261086, 4959.231319145538, 4988.326575912351, 4799.400074990626, 4857.368542089647, 4863.902721945612, 4869.074875773592, 4905.632077594123, 4749.667523273338, 4868.537488938545, 4870.610351171968, 5022.271770593316, 5090.745462726923, 4980.825671101494, 5039.395272567315, 5062.949370506395, 5072.82245121419, 5107.846764597068, 4942.505749425029, 4949.183384741477, 4955.900881982412, 4957.504249575014, 4997.525235102659, 4661.510541393241, 4727.976360118178, 4776.546228108324, 4938.530839570235, 4983.75081245929, 4737.928931066106, 4792.568668819823, 4812.0, 4816.975915120402, 4860.902781944271, 4882.877928051827, 4885.071836351082, 4892.3884514435695, 4912.0, 4925.261210818263, 4652.325412815055, 4777.856664300077, 4794.137055330074, 4796.736179510161, 4803.303520989367], "unit": "ms", "name": "dojo.html", "value": 4600.847464171589}, {"lowerIsBetter": false, "replicates": [545.4273013335999, 559.815260963882, 562.7467639562198, 572.4104172702116, 575.8963386590412, 27090.729092709065, 27838.025669101586, 38644.42033369498, 39022.60977390225, 39174.41238381426, 41944.790276048654, 42226.57773422265, 42514.7874260629, 42538.14923701532, 42580.08389622466, 7020.578765274075, 7917.920820791776, 8097.9595102024705, 8098.392620553453, 8100.594970251494, 7107.6090815005155, 10006.949965250164, 10231.386116832977, 10236.283460157792, 10240.231982601335, 10120.291579589431, 10223.846642300372, 10229.897701022968, 10232.795344093114, 10233.079022887938, 7233.240509746453, 7404.9629751851435, 10021.298509104365, 10089.545970431349, 10192.286539942206, 9584.95207523965, 9761.755956101084, 9763.463009534473, 9766.023397660249, 9769.853452198222, 38807.41788873169, 39155.60844391548, 39234.0, 39261.60738392608, 39345.40981885274, 2731.904383346593, 2853.671827739816, 2877.5252083406212, 2929.6191495105713, 3475.4960530722906, 28507.0, 28594.428111437865, 28792.42415151706, 29167.41665166706, 29267.707322926923, 3402.2515046689937, 3428.879989200391, 3451.36149812283, 3507.4037413639744, 3545.840437180333, 237208.0, 238356.0, 238571.0, 238782.0, 239072.0, 51513.22730159051, 53160.0, 53166.6833316673, 55991.0, 56572.717136414874, 49395.0, 49451.258231126565, 59963.100553491735, 60601.696991515644, 60728.69635651793, 11304.321740695585, 11498.48256828428, 11568.537258509734, 11602.825957610643, 11611.941940290244, 8950.23922966555, 9050.456972581665, 9058.0, 9074.047225041408, 9081.68214112503, 18397.90801045986, 18878.716819247722, 19133.0, 19135.617287654168, 19165.904170479338, 7611.162772095176, 7860.432128979325, 7994.880076798852, 8028.759137225892, 8033.517988920684, 770.9498882572615, 811.7686459359054, 842.7724514381083, 853.423938841292, 964.9723044957099, 26427.339316516856, 26800.840583616668, 27181.86409067942, 27222.183334499998, 27276.590851137247, 880.0231742765525, 885.9158379954023, 926.4441335198961, 944.2351695126969, 952.5761036338902, 12686.936565317113, 12771.297578633264, 12846.807297890538, 12873.35633218354, 13012.674683132998, 283838.0, 285886.0, 286055.0, 286292.0, 287330.0, 38074.619253807665, 38647.6135238644, 43798.562014380084, 44561.77719111449, 46867.0, 1142.948567314473, 1145.9083273338113, 1165.5046605192758, 1167.5038108803724, 1185.0815617896199, 23351.649725254476, 23811.76188238165, 25701.87149064243, 26805.731942680322, 27018.1894543164, 43124.0, 43342.783286083366, 43442.34836477392, 43611.78194109009, 43624.78187609042, 225371.0, 226815.0, 226892.0, 227004.0, 227695.0, 28518.0, 28641.283967900137, 28927.42145157127, 28939.131826045254, 28939.42121157607, 39773.0, 39779.60220397759, 39789.0, 40267.597324027556, 40710.0, 34456.310873781884, 34908.0, 35054.824725877224, 35067.0, 35451.468227977115, 34702.47946280858, 35052.64947350494, 35496.0, 37423.0, 37641.81179094087, 33149.17127071843, 34099.829500852335, 34133.65866341305, 34153.48769768505, 34167.31665366629, 28044.859775700992, 29958.5313046535, 30322.241943951576, 30580.541291881083, 30790.230244243176, 23266.0, 24237.878810605835, 24639.0, 24939.251822445356, 25817.612735809354], "unit": "ms", "name": "ext.html", "value": 17110.390388983622}, {"lowerIsBetter": false, "replicates": [337.1671970233524, 337.7736916266102, 341.5355117040824, 342.3717478427086, 343.5448031358451, 12545.498180072786, 12883.54907578235, 14914.0, 15098.0, 16422.0, 14271.643208919782, 14635.707285854303, 14821.11073335598, 14828.55514334569, 15075.095494270352, 3390.7965522068753, 4473.88815279619, 4595.839145629903, 5019.949800502003, 5022.522860328281, 4993.400791904976, 5018.5985121190215, 5022.748862556876, 5032.245163225509, 5034.119029169899, 4839.419269687643, 4944.826931057413, 4955.578775804061, 4971.428285747131, 5002.199648056312, 5042.369703787008, 5052.393712754475, 5052.898942021139, 5053.797848086072, 5060.746962651871, 4481.910361792746, 4482.820687172509, 4562.133194692998, 4563.840265590721, 4574.199515084847, 11772.117091218108, 11844.289342639384, 11848.289102653782, 11865.762684746256, 15607.609809754733, 1826.963460730778, 1855.944321670352, 1873.9250429982785, 1916.9808301916942, 1982.5241941933975, 9100.499472529009, 9347.112024357675, 9755.902440975642, 12557.121001529897, 13161.539346122936, 1734.7744793176805, 1761.3483011285778, 1762.5064981805115, 1782.5116028116538, 1814.5010122216363, 45561.316580251325, 45859.77070114695, 46395.768021160016, 46568.30147547789, 51999.48000519984, 9710.465924374086, 9878.950605246928, 9884.11043006133, 9909.405435673883, 9943.651972181084, 10758.0855627271, 10917.945410273056, 12309.56916507918, 12330.50677972889, 21720.23979160722, 7727.574983375968, 7832.0, 7868.685252589832, 7874.0, 7890.842183156419, 5740.770369185269, 5793.768249270066, 6397.6801159941815, 6442.581232219891, 6448.097266382711, 7410.814729631695, 7600.2779735925, 7633.480951286062, 7645.0, 7785.299323060952, 2872.755815755684, 2963.5702823090533, 2972.8959486418303, 2973.68776278492, 2990.4467673480476, 773.9071311442663, 860.6342304520679, 890.3055616619048, 902.5261737587819, 905.171767832426, 15314.387424502895, 15516.069035857885, 15756.68486630284, 15964.441244556385, 15986.0, 770.9653065612061, 794.2375319693044, 806.7418426103591, 840.6931470013401, 871.9258862996717, 7003.824904377431, 8809.823803523894, 8843.847564299545, 8961.103889610988, 9463.0, 506832.0, 510147.0, 529125.0, 535232.0, 536066.0, 67078.32921670818, 67385.0, 67915.66042169757, 68171.0, 69910.65044674846, 1000.9590026372637, 1022.8363461846218, 1063.984040239397, 1082.3289560472558, 1104.629948967089, 13510.392032358764, 13609.863901360859, 13665.0, 13763.38064787067, 14051.297435128407, 29555.261118472212, 29767.404651907273, 29815.85092074526, 31405.214869628442, 32540.674593253763, 35546.46680299849, 37220.62779372172, 37385.2522949534, 39293.41059884047, 40230.597694023854, 8357.791055223668, 8427.157284271523, 8653.956730216309, 8735.475871447734, 8766.34252431083, 15248.16135112535, 15249.23753812327, 15505.922470387575, 15584.766228506809, 15642.061476311457, 13288.0, 13436.193828369938, 13470.259135747629, 13703.314834258048, 14223.573292801233, 13463.528776493167, 13854.0, 14036.78944815849, 14098.295085245902, 14317.498887538886, 13981.790273145707, 14178.858211418166, 14188.858111418755, 14412.711745764816, 14704.485343012942, 8490.872636910328, 8743.475391476532, 8833.602487887933, 8867.556622168995, 9032.909670903207, 9069.002409734792, 9147.039560846282, 9151.267898568232, 10759.731006724895, 12602.432890520133], "unit": "ms", "name": "jquery.html", "value": 8270.508104915452}, {"lowerIsBetter": false, "replicates": [1248.475640231103, 1626.3657173702256, 1664.850163485286, 1682.0412364951983, 1686.9072201028941, 5816.505597024253, 6186.257649082111, 6376.266729326129, 6389.5846769960035, 6389.808305750829, 6535.11775910252, 6565.606063636185, 6620.702068406921, 6645.435138013275, 6649.43479804216, 1744.5551384397024, 1771.123293969487, 1775.4673597920637, 2030.9289174878882, 2050.2721533855492, 1787.0350010994048, 1788.7942886568017, 2020.0, 2041.8570700051002, 2050.538628808521, 1986.1261045140093, 2015.1234213117268, 2024.2307922989244, 2026.4224695961655, 2028.29009846554, 2052.138101997165, 2077.5948690005457, 2080.791920807907, 2082.2607974169177, 2082.7188329575465, 2026.6453370660222, 2035.0130186859362, 2061.7835127311714, 2063.9587208255753, 2069.379186244121, 6592.0, 6644.235912870034, 6646.23568289648, 6652.06871038055, 6652.667366631649, 3985.202959408101, 4049.4128351389177, 4050.5341885682933, 4056.6349028587274, 4057.0, 2681.8927242910454, 2720.8095433319677, 2733.603627474025, 2748.6014527893544, 2759.65504311961, 863.7797361672796, 864.6498168241872, 876.412803421709, 878.8286284174525, 896.7399454158286, 8335.166483351677, 8389.244967952853, 8404.285635720971, 8407.873881891777, 8416.284615807665, 3677.44838274261, 3717.386631205821, 3796.8291426885303, 3797.487339209227, 3828.444875493038, 7417.740379086706, 7471.0, 7483.363914067257, 7492.850142997109, 7495.512791668524, 4061.5329237137516, 4086.223617512663, 4089.8773036808943, 4124.0, 4129.855455059119, 3725.5343082114737, 3738.887833365003, 3755.6807671348242, 3756.887293381203, 3757.4363845423404, 2853.6432945881766, 3253.3493301339354, 3298.0, 3339.348826978716, 3343.8996830095134, 937.6952490440634, 1010.2069875147973, 1017.4810846468206, 1028.4806172882647, 1041.068243921686, 777.6150805351274, 818.2349503214514, 822.1778221778221, 822.9588520574067, 904.3759805734022, 6074.665893375906, 6135.049067394561, 6186.505079593711, 6194.225721784777, 6196.132541444202, 998.9001099890098, 1000.7848312612823, 1008.1481148429712, 1019.2661283875598, 1027.9691609251734, 4977.402711674622, 5054.16606259963, 5056.165732654144, 5058.772355243949, 5061.240813877947, 7600.46796724224, 7655.0, 7745.148033716287, 7835.373170146375, 7837.725679601301, 7610.277023682741, 7664.11862635804, 7665.463417560717, 7694.0, 7734.265244801735, 6067.544934129958, 6127.5404344674325, 6143.1706719592285, 6184.165137706442, 6197.81406557804, 6211.9689401552705, 6247.9062814056915, 6248.562600617913, 6312.589681670676, 6314.810555683337, 6660.6336651484635, 7011.018457416068, 7037.859242815218, 7098.331892005272, 7160.749373771893, 7168.351279205916, 7183.604901730246, 7206.027186329988, 7299.0, 7382.889256661047, 5963.642181469126, 6037.607555508878, 6039.63762174271, 6050.394960503914, 6052.122442245762, 5701.230333904869, 6484.319146489551, 6519.641419721961, 6534.117894084237, 6540.051692504655, 5604.579656525859, 5734.569907257056, 6042.274927008787, 6095.817125486065, 6136.079588061826, 5896.823095307148, 5974.731137098928, 6035.818925432244, 6050.878982420415, 6106.816795496142, 6049.969750151221, 6063.696815159136, 6091.756329746938, 6099.207103076572, 6099.786507472217, 5690.146478028163, 5723.399043100415, 5734.684592347461, 5739.942600573941, 5745.109508026263, 5503.889922201613, 5584.329880414376, 5815.3893841147765, 5835.9708201458725, 5846.883062338815], "unit": "ms", "name": "mootools.html", "value": 3855.3580663523176}, {"lowerIsBetter": false, "replicates": [310.81661819526477, 318.72908028176056, 320.2138749370295, 321.66225463263567, 322.4824157227651, 5298.7350632468315, 5360.463953604638, 5387.814680770229, 5388.8922221555595, 5413.918791218125, 5069.923951140727, 5097.59219262459, 5203.089459344618, 5302.522772950434, 5342.385625653051, 4167.083241686832, 4181.080162364275, 4206.369044643313, 4222.15556888622, 4229.513605935311, 3986.8604598839047, 4223.0, 4224.556421575737, 4227.788610569474, 4237.7669228192435, 4028.1742242840296, 4057.5942405759483, 4173.123644034757, 4178.895527611819, 4193.937090943638, 4167.437395951538, 4171.374293855946, 4173.768738222232, 4175.853845115436, 4177.728447650893, 3670.7981061041633, 3672.320620685182, 3682.0426689061037, 3682.5396825396824, 3683.797391143486, 5127.897442051175, 5183.974080129575, 5197.168453047494, 5207.3751149862255, 5208.583313334924, 4636.86089417318, 4769.713817170981, 4790.113828941657, 4815.66290359675, 4816.0, 5702.486776190121, 5706.201131841545, 5710.543156547507, 5713.314402271712, 5714.542836573064, 3983.50206224222, 3992.900177495557, 3995.220931918277, 3996.0409501719378, 3996.48045754053, 5887.646741195542, 5972.731227094791, 5991.3109992351, 5994.610350327258, 6001.4298641628975, 3966.5636779954184, 4110.034141976633, 4118.608732170439, 4121.464209652786, 4132.40080188377, 4167.812448439828, 4175.16496700655, 4178.373244013423, 4185.246655602021, 4190.580941905846, 4789.616830653539, 4796.328514008042, 4800.3279540864305, 4802.51974802517, 4806.567408933212, 5718.513926316226, 5718.628289161275, 5721.199032135504, 5721.914171287434, 5727.656340619576, 1431.921244331551, 1457.7521821290406, 1474.8820094392422, 1475.963100922464, 1482.2514630111725, 967.9225661947028, 990.4601991914279, 998.0368943969105, 1007.7178390050798, 1008.5259927833906, 4980.0, 4997.800087996512, 5001.8499445016705, 5001.974990125026, 5002.99940011999, 5894.145348924382, 5903.144044113666, 5909.349971503131, 5909.497692696083, 5922.644641321534, 4842.685225460405, 4915.508449155127, 4983.8504844854715, 4984.40187177541, 5070.6957582545165, 3190.7128358447853, 3209.2618697699195, 3215.7748957572744, 3224.725898298624, 3229.3864165808423, 5628.71856407178, 5636.746346414421, 5638.267025286768, 5641.605087643908, 5649.12438572022, 6003.039513677791, 6110.327863934964, 6138.907916381258, 6144.262688477412, 6144.603604594212, 5627.465390787868, 5636.408177141341, 5637.577181711388, 5638.295213098363, 5650.011248031578, 5942.494887934574, 5967.6419414835245, 5971.253593300838, 5971.910421343597, 5981.970090149695, 5796.8550786229, 5812.622179558315, 5821.679807610622, 5832.650040997553, 5833.504152147115, 5496.640775244265, 5581.804636837691, 5600.467955544217, 5627.296587926509, 5628.831135065954, 4060.16766562848, 4081.306177949696, 4084.0810817567, 4084.8774536763945, 4089.836406543705, 5952.315483719428, 5958.851028724316, 5960.642361458326, 5964.194833697569, 5965.254343207099, 5608.691521966331, 5732.7706891723865, 5737.08206686928, 5738.856528586652, 5741.741621626953, 5730.684812335361, 5730.71346432685, 5733.283339582552, 5735.684537350319, 5746.569007324551, 5603.859903502445, 5608.635438696471, 5611.607187496836, 5612.887742245214, 5615.0, 5654.575906806924, 5773.624714393551, 5773.653580785166, 5776.133579963039, 5777.22007528995, 5615.747291371817, 5621.072523033818, 5623.662580245198, 5629.577781666309, 5629.943700563106], "unit": "ms", "name": "prototype.html", "value": 4289.743312046998}, {"lowerIsBetter": false, "replicates": [670.7048898484667, 710.6931992127705, 748.8577170337635, 761.756238003839, 795.2127393880061, 10866.673999780009, 11793.823092653616, 11807.0, 11817.822732659017, 11819.763604727901, 11954.222975506585, 11954.402279886015, 12037.097217708684, 12049.096317776159, 12067.0949678774, 618.656645561713, 628.6448156791421, 783.6943591999125, 787.8384931089141, 802.7952872017627, 799.0331698644646, 800.5356893002045, 803.445622520459, 805.0379796143582, 805.1948051948052, 829.1666874790827, 835.2649668291925, 841.4194205997873, 842.4650347029619, 843.3295530053591, 652.7128063652002, 660.0099850224663, 826.0, 838.9538575378351, 841.4530555139147, 622.6637615687523, 622.7851391270004, 622.8972219583763, 623.1120653069358, 623.9095331176999, 11021.173411994052, 11105.056070234039, 11134.888651113466, 11154.776904461947, 11164.888351116466, 11085.778284434266, 11126.944365278203, 11265.605703800327, 11330.320180789178, 11438.485268162953, 9087.318451116193, 9117.407368521091, 9343.205827504671, 9412.67055653049, 9466.526673666358, 3053.92365190872, 3109.8289594072317, 3114.7508199343997, 3116.7350775184136, 3165.335279591289, 39212.41181382253, 39234.80382598098, 39262.80368598167, 39403.0, 39409.40885886714, 9407.247420206368, 9411.952940235393, 9462.432254064779, 9521.809563808823, 9666.323357365058, 16839.41062062822, 16937.745933811002, 16946.745798813026, 16969.745453818203, 16986.405475808286, 6339.524535659752, 6388.297287298394, 6412.67936603168, 6464.482841372679, 6566.606003639797, 3584.4981702561663, 3622.7645203061716, 3646.1431563582537, 3648.325059863934, 3709.7217708671956, 2695.3531152523647, 2728.4133911209187, 2728.481588498179, 2733.139061195717, 2742.3418379588757, 473.11527443680535, 491.0302153247308, 495.6035171862496, 547.8520799384144, 567.4439049731204, 588.2323567744135, 592.3217915486744, 618.9102580125857, 619.2785405003211, 626.4299487466384, 8032.678692852221, 8704.0, 8840.8673869892, 8887.511186884783, 8939.418937769024, 569.0894568690145, 583.1311346094288, 598.7545106506311, 627.0844566932238, 627.3726273726273, 3634.854605815791, 3784.070124236659, 3802.144517483544, 3833.750806197588, 3841.3661745812187, 47091.0, 47968.0, 47988.04023919502, 48055.0, 48177.0, 43725.0, 44293.778531107135, 44516.77741611271, 44576.777116114215, 45391.773041135246, 40216.0, 40968.38547421791, 41046.384304235464, 41930.580694193275, 42062.15875682469, 8168.83662326762, 8358.582070896553, 8422.410431269753, 8539.914600853912, 8623.490889094508, 32637.836810815796, 32786.0, 33066.834665826515, 33083.834580826944, 33331.666683332856, 39506.60493395029, 40836.1832763349, 41140.38289425721, 41183.58816411797, 41403.79298103611, 9834.21326293909, 9843.704688859345, 9930.801383972135, 9949.353292035994, 10057.748556286151, 11352.091832653534, 11399.544018239509, 11459.31244125355, 11548.538058477903, 11641.767164656829, 10404.68785936423, 10751.6236931707, 10810.24328297043, 11272.436378181223, 11297.887021129683, 10410.791784164427, 10546.894531054899, 10623.946880265548, 10866.511007004545, 10894.0, 10207.0, 10437.895621043996, 10513.474326283807, 10514.474276286002, 10626.628068017582, 8958.372913895964, 9077.546122693971, 9106.95446522763, 9351.39215950961, 9357.906420935704, 8761.386702930733, 9082.818343633222, 9229.169374756304, 9428.99758675527, 9646.083622055894], "unit": "ms", "name": "yui.html", "value": 5771.163906185179}], "name": "dromaeo_css", "value": 6293.701300137651}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 115.0, 107.0, 112.0, 114.0, 120.0, 104.0, 113.0, 104.0, 114.0], "unit": "ms", "name": "ai-astar", "value": 111.6}, {"lowerIsBetter": true, "replicates": [157.0, 131.0, 150.0, 166.0, 132.0, 153.0, 158.0, 131.0, 167.0, 133.0], "unit": "ms", "name": "audio-beat-detection", "value": 147.8}, {"lowerIsBetter": true, "replicates": [164.0, 162.0, 161.0, 161.0, 161.0, 161.0, 161.0, 162.0, 163.0, 164.0], "unit": "ms", "name": "audio-dft", "value": 162.0}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 83.0, 91.0, 77.0, 74.0, 74.0, 107.0, 92.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 81.6}, {"lowerIsBetter": true, "replicates": [92.0, 91.0, 129.0, 92.0, 91.0, 91.0, 145.0, 91.0, 92.0, 126.0], "unit": "ms", "name": "audio-oscillator", "value": 104.0}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 148.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 69.0, 70.0, 69.0, 70.0, 71.0, 78.0, 67.0, 69.0], "unit": "ms", "name": "json-parse-financial", "value": 70.4}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 69.0, 69.0, 70.0, 69.0, 69.0, 68.0, 68.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.9}, {"lowerIsBetter": true, "replicates": [82.0, 84.0, 84.0, 82.0, 82.0, 82.0, 84.0, 83.0, 85.0, 81.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 82.9}, {"lowerIsBetter": true, "replicates": [121.0, 118.0, 129.0, 125.0, 123.0, 119.0, 121.0, 125.0, 120.0, 127.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 122.8}, {"lowerIsBetter": true, "replicates": [139.0, 157.0, 143.0, 141.0, 166.0, 142.0, 137.0, 154.0, 154.0, 142.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 147.5}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 68.0, 72.0, 69.0, 71.0, 70.0, 79.0, 69.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 70.5}], "name": "kraken", "value": 1521.4}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [163.3986928104575], "unit": "score", "name": "Richards", "value": 216.04823999999994}, {"lowerIsBetter": false, "replicates": [193.16206297083252], "unit": "score", "name": "DeltaBlue", "value": 342.292886}, {"lowerIsBetter": false, "replicates": [282.7254735651682], "unit": "score", "name": "Encrypt", "value": 941.4821969999996}, {"lowerIsBetter": false, "replicates": [5035.175879396985], "unit": "score", "name": "Decrypt", "value": 52.864290419161705}, {"lowerIsBetter": false, "replicates": [2176.086956521739], "unit": "score", "name": "RayTrace", "value": 340.0548851148853}, {"lowerIsBetter": false, "replicates": [793.6507936507936], "unit": "score", "name": "Earley", "value": 839.7433799999998}, {"lowerIsBetter": false, "replicates": [12304.878048780487], "unit": "score", "name": "Boyer", "value": 54.16250346878094}, {"lowerIsBetter": false, "replicates": [26736.842105263157], "unit": "score", "name": "RegExp", "value": 34.07227362204725}, {"lowerIsBetter": false, "replicates": [598.4578884934757], "unit": "score", "name": "Splay", "value": 136.16831119920707}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 19609.080351786124}]} 06:00:38 INFO - RETURN: dromaeo_css: 6293.70 06:00:38 INFO - RETURN: kraken: 1521.40 06:00:38 INFO - RETURN: v8_7: 19609.08 06:00:38 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19609.08"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1521.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6293.70"}}} 06:00:39 INFO - Return code: 0 06:00:39 INFO - # TBPL SUCCESS # 06:00:39 INFO - Running post-action listener: _resource_record_post_action 06:00:39 INFO - Running post-run listener: _resource_record_post_run 06:00:40 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 217088; Write bytes: 266596352; Read time: 52; Write time: 216132 06:00:40 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 540672; Read time: 0; Write time: 60 06:00:40 INFO - run-tests - Wall time: 1221s; CPU: 13.0%; Read bytes: 212992; Write bytes: 266055680; Read time: 44; Write time: 216072 06:00:40 INFO - Running post-run listener: _upload_blobber_files 06:00:40 INFO - Blob upload gear active. 06:00:40 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 06:00:40 INFO - Copying logs to upload dir... 06:00:40 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1265.590521 ========= master_lag: -0.20 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2015-11-23 06:00:39.831551) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 06:00:39.835368) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0ae9de487587ba4b94dd3100000001b5-1448285659.242344-1684323083 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009986 build_url: 'https://queue.taskcluster.net/v1/task/gewOLAYdT8SnmmRBdBc0dA/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 06:00:39.885779) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 06:00:39.886100) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0ae9de487587ba4b94dd3100000001b5-1448285659.242344-1684323083 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004509 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 06:00:39.936003) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 06:00:39.936302) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 06:00:39.936593) ========= ========= Total master_lag: 0.03 =========