builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-011 starttime: 1448038595.9 results: success (0) buildid: 20151120082241 builduid: 4b45c443ad7d4f5e94b76aa64210f7b6 revision: 1f9d9bfafd5143618083adcd50f5fcb0fead5530 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 08:56:35.898351) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 08:56:35.898870) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 08:56:35.899192) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1448038595.487458-1567052119 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006499 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 08:56:35.916773) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 08:56:35.917096) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 08:56:35.924998) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 08:56:35.925286) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1448038595.487458-1567052119 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004119 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 08:56:35.973056) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 08:56:35.973356) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 08:56:35.973721) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 08:56:35.973992) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1448038595.487458-1567052119 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-20 08:56:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 63.5M=0s 2015-11-20 08:56:36 (63.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.220429 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 08:56:36.207945) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 08:56:36.208271) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1448038595.487458-1567052119 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018035 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 08:56:36.258062) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 08:56:36.258415) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1f9d9bfafd5143618083adcd50f5fcb0fead5530 --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 1f9d9bfafd5143618083adcd50f5fcb0fead5530 --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=76a4ffbc7ba64825c1a171dc000001de-1448038595.487458-1567052119 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-20 08:56:36,565 truncating revision to first 12 chars 2015-11-20 08:56:36,565 Setting DEBUG logging. 2015-11-20 08:56:36,565 attempt 1/10 2015-11-20 08:56:36,565 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1f9d9bfafd51?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-20 08:56:36,850 unpacking tar archive at: fx-team-1f9d9bfafd51/testing/mozharness/ program finished with exit code 0 elapsedTime=0.558826 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 08:56:36.830162) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 08:56:36.830493) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 08:56:36.839729) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 08:56:36.840016) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 08:56:36.840517) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-11-20 08:56:36.840872) ========= /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=76a4ffbc7ba64825c1a171dc000001de-1448038595.487458-1567052119 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:56:37 INFO - MultiFileLogger online at 20151120 08:56:37 in /builds/slave/test 08:56:37 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 08:56:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:56:37 INFO - {'append_to_log': False, 08:56:37 INFO - 'base_work_dir': '/builds/slave/test', 08:56:37 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 08:56:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:56:37 INFO - 'branch': 'Fx-Team-Non-PGO', 08:56:37 INFO - 'buildbot_json_path': 'buildprops.json', 08:56:37 INFO - 'config_files': ('talos/linux_config.py',), 08:56:37 INFO - 'default_actions': ('clobber', 08:56:37 INFO - 'read-buildbot-config', 08:56:37 INFO - 'download-and-extract', 08:56:37 INFO - 'populate-webroot', 08:56:37 INFO - 'create-virtualenv', 08:56:37 INFO - 'install', 08:56:37 INFO - 'run-tests'), 08:56:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:56:37 INFO - 'download_minidump_stackwalk': True, 08:56:37 INFO - 'download_symbols': 'ondemand', 08:56:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:56:37 INFO - 'tooltool.py': '/tools/tooltool.py', 08:56:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:56:37 INFO - '/tools/misc-python/virtualenv.py')}, 08:56:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:56:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:56:37 INFO - 'installer_path': 'installer.exe', 08:56:37 INFO - 'log_level': 'info', 08:56:37 INFO - 'log_name': 'talos', 08:56:37 INFO - 'log_to_console': True, 08:56:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:56:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:56:37 INFO - 'opt_config_files': (), 08:56:37 INFO - 'pip_index': False, 08:56:37 INFO - 'sps_profile': False, 08:56:37 INFO - 'sps_profile_interval': 0, 08:56:37 INFO - 'suite': 'dromaeojs', 08:56:37 INFO - 'system_bits': '64', 08:56:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:56:37 INFO - 'title': 'talos-linux64-ix-011', 08:56:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:56:37 INFO - 'use_talos_json': True, 08:56:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:56:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:56:37 INFO - 'work_dir': 'build'} 08:56:37 INFO - ##### 08:56:37 INFO - ##### Running clobber step. 08:56:37 INFO - ##### 08:56:37 INFO - Running pre-action listener: _resource_record_pre_action 08:56:37 INFO - Running main action method: clobber 08:56:37 INFO - rmtree: /builds/slave/test/build 08:56:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:56:37 INFO - Running post-action listener: _resource_record_post_action 08:56:37 INFO - ##### 08:56:37 INFO - ##### Running read-buildbot-config step. 08:56:37 INFO - ##### 08:56:37 INFO - Running pre-action listener: _resource_record_pre_action 08:56:37 INFO - Running main action method: read_buildbot_config 08:56:37 INFO - Using buildbot properties: 08:56:37 INFO - { 08:56:37 INFO - "properties": { 08:56:37 INFO - "buildnumber": 2099, 08:56:37 INFO - "product": "firefox", 08:56:37 INFO - "script_repo_revision": "production", 08:56:37 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:56:37 INFO - "repository": "", 08:56:37 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 08:56:37 INFO - "buildid": "20151120082241", 08:56:37 INFO - "slavename": "talos-linux64-ix-011", 08:56:37 INFO - "pgo_build": "False", 08:56:37 INFO - "basedir": "/builds/slave/test", 08:56:37 INFO - "project": "", 08:56:37 INFO - "platform": "ubuntu64_hw", 08:56:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:56:37 INFO - "slavebuilddir": "test", 08:56:37 INFO - "scheduler": "tests-fx-team-linux64-talos", 08:56:37 INFO - "branch": "fx-team", 08:56:37 INFO - "repo_path": "integration/fx-team", 08:56:37 INFO - "stage_platform": "linux64", 08:56:37 INFO - "builduid": "4b45c443ad7d4f5e94b76aa64210f7b6", 08:56:37 INFO - "revision": "1f9d9bfafd5143618083adcd50f5fcb0fead5530" 08:56:37 INFO - }, 08:56:37 INFO - "sourcestamp": { 08:56:37 INFO - "repository": "", 08:56:37 INFO - "hasPatch": false, 08:56:37 INFO - "project": "", 08:56:37 INFO - "branch": "fx-team-linux64-talos", 08:56:37 INFO - "changes": [ 08:56:37 INFO - { 08:56:37 INFO - "category": null, 08:56:37 INFO - "files": [ 08:56:37 INFO - { 08:56:37 INFO - "url": null, 08:56:37 INFO - "name": "https://queue.taskcluster.net/v1/task/uaCOO9oFQL-duv7raIGe1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 08:56:37 INFO - } 08:56:37 INFO - ], 08:56:37 INFO - "repository": "", 08:56:37 INFO - "rev": "1f9d9bfafd5143618083adcd50f5fcb0fead5530", 08:56:37 INFO - "who": "mconley@mozilla.com", 08:56:37 INFO - "when": 1448038548, 08:56:37 INFO - "number": 6689387, 08:56:37 INFO - "comments": "Bug 1213650 - Stash the last value of lastArguments to navigateAndRestore to restore with. r=Mossop", 08:56:37 INFO - "project": "", 08:56:37 INFO - "at": "Fri 20 Nov 2015 08:55:48", 08:56:37 INFO - "branch": "fx-team-linux64-talos", 08:56:37 INFO - "revlink": "", 08:56:37 INFO - "properties": [ 08:56:37 INFO - [ 08:56:37 INFO - "buildid", 08:56:37 INFO - "20151120082241", 08:56:37 INFO - "Change" 08:56:37 INFO - ], 08:56:37 INFO - [ 08:56:37 INFO - "builduid", 08:56:37 INFO - "4b45c443ad7d4f5e94b76aa64210f7b6", 08:56:37 INFO - "Change" 08:56:37 INFO - ], 08:56:37 INFO - [ 08:56:37 INFO - "pgo_build", 08:56:37 INFO - "False", 08:56:37 INFO - "Change" 08:56:37 INFO - ] 08:56:37 INFO - ], 08:56:37 INFO - "revision": "1f9d9bfafd5143618083adcd50f5fcb0fead5530" 08:56:37 INFO - } 08:56:37 INFO - ], 08:56:37 INFO - "revision": "1f9d9bfafd5143618083adcd50f5fcb0fead5530" 08:56:37 INFO - } 08:56:37 INFO - } 08:56:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/uaCOO9oFQL-duv7raIGe1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 08:56:37 INFO - Running post-action listener: _resource_record_post_action 08:56:37 INFO - ##### 08:56:37 INFO - ##### Running download-and-extract step. 08:56:37 INFO - ##### 08:56:37 INFO - Running pre-action listener: _resource_record_pre_action 08:56:37 INFO - Running main action method: download_and_extract 08:56:37 INFO - mkdir: /builds/slave/test/build/tests 08:56:37 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')]} 08:56:37 INFO - https://queue.taskcluster.net/v1/task/uaCOO9oFQL-duv7raIGe1Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:56:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uaCOO9oFQL-duv7raIGe1Q/artifacts/public/build/test_packages.json 08:56:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uaCOO9oFQL-duv7raIGe1Q/artifacts/public/build/test_packages.json 08:56:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uaCOO9oFQL-duv7raIGe1Q/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 08:56:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uaCOO9oFQL-duv7raIGe1Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 08:56:43 INFO - Downloaded 1302 bytes. 08:56:43 INFO - Reading from file /builds/slave/test/build/test_packages.json 08:56:43 INFO - Using the following test package requirements: 08:56:43 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 08:56:43 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:56:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:56:43 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:56:43 INFO - u'jsshell-linux-x86_64.zip'], 08:56:43 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:56:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:56:43 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 08:56:43 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:56:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:56:43 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:56:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:56:43 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:56:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:56:43 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 08:56:43 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:56:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:56:43 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:56: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')]} 08:56:43 INFO - https://queue.taskcluster.net/v1/task/uaCOO9oFQL-duv7raIGe1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:56:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uaCOO9oFQL-duv7raIGe1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:56:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uaCOO9oFQL-duv7raIGe1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:56:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uaCOO9oFQL-duv7raIGe1Q/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 08:56:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uaCOO9oFQL-duv7raIGe1Q/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 08:56:45 INFO - Downloaded 21340206 bytes. 08:56:45 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 08:56:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:56:45 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 08:56:46 INFO - Return code: 0 08:56:46 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 08:56:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:56:46 INFO - https://queue.taskcluster.net/v1/task/uaCOO9oFQL-duv7raIGe1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:56:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uaCOO9oFQL-duv7raIGe1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:56:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uaCOO9oFQL-duv7raIGe1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:56:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uaCOO9oFQL-duv7raIGe1Q/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 08:56:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uaCOO9oFQL-duv7raIGe1Q/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 08:56:47 INFO - Downloaded 21340206 bytes. 08:56:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 08:56:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:56:47 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 08:56:48 INFO - Return code: 0 08:56: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')]} 08:56:48 INFO - https://queue.taskcluster.net/v1/task/uaCOO9oFQL-duv7raIGe1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:56:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uaCOO9oFQL-duv7raIGe1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 08:56:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uaCOO9oFQL-duv7raIGe1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 08:56:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uaCOO9oFQL-duv7raIGe1Q/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 08:56:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uaCOO9oFQL-duv7raIGe1Q/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 08:56:50 INFO - Downloaded 11130997 bytes. 08:56:50 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 08:56:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 08:56:50 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 08:56:50 INFO - Return code: 0 08:56:50 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')]} 08:56:50 INFO - https://queue.taskcluster.net/v1/task/uaCOO9oFQL-duv7raIGe1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:56:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uaCOO9oFQL-duv7raIGe1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 08:56:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uaCOO9oFQL-duv7raIGe1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 08:56:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uaCOO9oFQL-duv7raIGe1Q/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 08:56:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uaCOO9oFQL-duv7raIGe1Q/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 08:56:59 INFO - Downloaded 55781083 bytes. 08:56:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/uaCOO9oFQL-duv7raIGe1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 08:56:59 INFO - mkdir: /builds/slave/test/properties 08:56:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:56:59 INFO - Writing to file /builds/slave/test/properties/build_url 08:56:59 INFO - Contents: 08:56:59 INFO - build_url:https://queue.taskcluster.net/v1/task/uaCOO9oFQL-duv7raIGe1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 08:56:59 INFO - Running post-action listener: _resource_record_post_action 08:56:59 INFO - Running post-action listener: set_extra_try_arguments 08:56:59 INFO - ##### 08:56:59 INFO - ##### Running populate-webroot step. 08:56:59 INFO - ##### 08:56:59 INFO - Running pre-action listener: _resource_record_pre_action 08:56:59 INFO - Running main action method: populate_webroot 08:56:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:56:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:56:59 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 08:56:59 INFO - '../fennec_ids.txt'], 08:56:59 INFO - 'tests': ['tcheck2']}, 08:56:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:56:59 INFO - '--tppagecycles', 08:56:59 INFO - '7'], 08:56:59 INFO - 'tests': ['tsvgm']}}, 08:56:59 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:56:59 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:56:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:56:59 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:56:59 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:56:59 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:56:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:56:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:56:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:56:59 INFO - 'talos_options': ['--e10s'], 08:56:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:56:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:56:59 INFO - 'tests': ['damp', 'tps']}, 08:56:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:56:59 INFO - 'talos_options': ['--e10s'], 08:56:59 INFO - 'tests': ['damp', 'tps']}, 08:56:59 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:56:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:56:59 INFO - 'other': {'tests': ['a11yr', 08:56:59 INFO - 'ts_paint', 08:56:59 INFO - 'tpaint', 08:56:59 INFO - 'sessionrestore', 08:56:59 INFO - 'sessionrestore_no_auto_restore']}, 08:56:59 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:56:59 INFO - 'tests': ['a11yr', 08:56:59 INFO - 'ts_paint', 08:56:59 INFO - 'tpaint', 08:56:59 INFO - 'sessionrestore', 08:56:59 INFO - 'sessionrestore_no_auto_restore']}, 08:56:59 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:56:59 INFO - 'tests': ['a11yr', 08:56:59 INFO - 'ts_paint', 08:56:59 INFO - 'tpaint', 08:56:59 INFO - 'sessionrestore', 08:56:59 INFO - 'sessionrestore_no_auto_restore']}, 08:56:59 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:56:59 INFO - 'tests': ['a11yr', 08:56:59 INFO - 'ts_paint', 08:56:59 INFO - 'tpaint', 08:56:59 INFO - 'sessionrestore', 08:56:59 INFO - 'sessionrestore_no_auto_restore']}, 08:56:59 INFO - 'other_l64': {'tests': ['a11yr', 08:56:59 INFO - 'ts_paint', 08:56:59 INFO - 'tpaint', 08:56:59 INFO - 'sessionrestore', 08:56:59 INFO - 'sessionrestore_no_auto_restore']}, 08:56:59 INFO - 'other_nol64': {'tests': ['a11yr', 08:56:59 INFO - 'ts_paint', 08:56:59 INFO - 'tpaint', 08:56:59 INFO - 'sessionrestore', 08:56:59 INFO - 'sessionrestore_no_auto_restore']}, 08:56:59 INFO - 'svgr': {'tests': ['tsvgx', 08:56:59 INFO - 'tsvgr_opacity', 08:56:59 INFO - 'tart', 08:56:59 INFO - 'tscrollx', 08:56:59 INFO - 'cart']}, 08:56:59 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:56:59 INFO - 'tests': ['tsvgx', 08:56:59 INFO - 'tsvgr_opacity', 08:56:59 INFO - 'tart', 08:56:59 INFO - 'tscrollx', 08:56:59 INFO - 'cart']}, 08:56:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:56:59 INFO - 'tests': ['tp5o']}, 08:56:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:56:59 INFO - 'talos_options': ['--e10s'], 08:56:59 INFO - 'tests': ['tp5o']}, 08:56:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:56:59 INFO - 'talos_options': ['--xperf_path', 08:56:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:56:59 INFO - 'tests': ['tp5n']}, 08:56:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:56:59 INFO - 'talos_options': ['--e10s', 08:56:59 INFO - '--xperf_path', 08:56:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:56:59 INFO - 'tests': ['tp5n']}}, 08:56:59 INFO - 'talos.zip': {'path': '', 08:56:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:56:59 INFO - Running post-action listener: _resource_record_post_action 08:56:59 INFO - ##### 08:56:59 INFO - ##### Running create-virtualenv step. 08:56:59 INFO - ##### 08:56:59 INFO - Running pre-action listener: _resource_record_pre_action 08:56:59 INFO - Running main action method: create_virtualenv 08:56:59 INFO - Creating virtualenv /builds/slave/test/build/venv 08:56:59 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:56:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:56:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:56:59 INFO - Using real prefix '/usr' 08:56:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:57:00 INFO - Installing distribute.............................................................................................................................................................................................done. 08:57:02 INFO - Installing pip.................done. 08:57:02 INFO - Return code: 0 08:57:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:57:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:57:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:57:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:57:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f249db02c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208a6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x213b900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2181b70>, '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 0x21d2dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d3250>, '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': '76a4ffbc7ba64825c1a171dc000001de-1448038595.487458-1567052119', '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 08:57:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:57:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:57:02 INFO - Using env: {'DISPLAY': ':0', 08:57:02 INFO - 'HOME': '/home/cltbld', 08:57:02 INFO - 'LANG': 'en_US.UTF-8', 08:57:02 INFO - 'LANGUAGE': 'en_US:en', 08:57:02 INFO - 'LOGNAME': 'cltbld', 08:57:02 INFO - 'MAIL': '/var/mail/cltbld', 08:57:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:57:02 INFO - 'MOZ_NO_REMOTE': '1', 08:57:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:57:02 INFO - 'NO_EM_RESTART': '1', 08:57:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:57:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:57:02 INFO - 'PWD': '/builds/slave/test', 08:57:02 INFO - 'SHELL': '/bin/bash', 08:57:02 INFO - 'SHLVL': '1', 08:57:02 INFO - 'TERM': 'linux', 08:57:02 INFO - 'TMOUT': '86400', 08:57:02 INFO - 'USER': 'cltbld', 08:57:02 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1448038595.487458-1567052119', 08:57:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:57:02 INFO - '_': '/tools/buildbot/bin/python'} 08:57:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:57:02 INFO - Cleaning up... 08:57:02 INFO - Return code: 0 08:57:02 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:57:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:57:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:57:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:57:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f249db02c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208a6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x213b900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2181b70>, '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 0x21d2dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d3250>, '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': '76a4ffbc7ba64825c1a171dc000001de-1448038595.487458-1567052119', '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 08:57:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 08:57:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 08:57:02 INFO - Using env: {'DISPLAY': ':0', 08:57:02 INFO - 'HOME': '/home/cltbld', 08:57:02 INFO - 'LANG': 'en_US.UTF-8', 08:57:02 INFO - 'LANGUAGE': 'en_US:en', 08:57:02 INFO - 'LOGNAME': 'cltbld', 08:57:02 INFO - 'MAIL': '/var/mail/cltbld', 08:57:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:57:02 INFO - 'MOZ_NO_REMOTE': '1', 08:57:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:57:02 INFO - 'NO_EM_RESTART': '1', 08:57:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:57:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:57:02 INFO - 'PWD': '/builds/slave/test', 08:57:02 INFO - 'SHELL': '/bin/bash', 08:57:02 INFO - 'SHLVL': '1', 08:57:02 INFO - 'TERM': 'linux', 08:57:02 INFO - 'TMOUT': '86400', 08:57:02 INFO - 'USER': 'cltbld', 08:57:02 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1448038595.487458-1567052119', 08:57:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:57:02 INFO - '_': '/tools/buildbot/bin/python'} 08:57:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:57:02 INFO - Downloading/unpacking psutil>=0.7.1 08:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:57:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:57:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:57:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:57:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:57:04 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 08:57:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 08:57:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:57:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:57:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:57:04 INFO - Installing collected packages: psutil 08:57:04 INFO - Running setup.py install for psutil 08:57:04 INFO - building 'psutil._psutil_linux' extension 08:57:04 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:57:04 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:57:04 INFO - building 'psutil._psutil_posix' extension 08:57:04 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:57:05 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 08:57:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:57:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:57:05 INFO - Successfully installed psutil 08:57:05 INFO - Cleaning up... 08:57:05 INFO - Return code: 0 08:57:05 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:57:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:57:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:57:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:57:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:57:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f249db02c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208a6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x213b900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2181b70>, '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 0x21d2dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d3250>, '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': '76a4ffbc7ba64825c1a171dc000001de-1448038595.487458-1567052119', '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 08:57:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 08:57:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 08:57:05 INFO - Using env: {'DISPLAY': ':0', 08:57:05 INFO - 'HOME': '/home/cltbld', 08:57:05 INFO - 'LANG': 'en_US.UTF-8', 08:57:05 INFO - 'LANGUAGE': 'en_US:en', 08:57:05 INFO - 'LOGNAME': 'cltbld', 08:57:05 INFO - 'MAIL': '/var/mail/cltbld', 08:57:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:57:05 INFO - 'MOZ_NO_REMOTE': '1', 08:57:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:57:05 INFO - 'NO_EM_RESTART': '1', 08:57:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:57:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:57:05 INFO - 'PWD': '/builds/slave/test', 08:57:05 INFO - 'SHELL': '/bin/bash', 08:57:05 INFO - 'SHLVL': '1', 08:57:05 INFO - 'TERM': 'linux', 08:57:05 INFO - 'TMOUT': '86400', 08:57:05 INFO - 'USER': 'cltbld', 08:57:05 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1448038595.487458-1567052119', 08:57:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:57:05 INFO - '_': '/tools/buildbot/bin/python'} 08:57:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:57:05 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:57:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:57:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:57:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:57:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:57:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:57:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:57:07 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:57:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 08:57:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:57:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:57:07 INFO - Installing collected packages: mozsystemmonitor 08:57:07 INFO - Running setup.py install for mozsystemmonitor 08:57:07 INFO - Successfully installed mozsystemmonitor 08:57:07 INFO - Cleaning up... 08:57:07 INFO - Return code: 0 08:57:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:57:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:57:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:57:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:57:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:57:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f249db02c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208a6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x213b900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2181b70>, '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 0x21d2dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d3250>, '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': '76a4ffbc7ba64825c1a171dc000001de-1448038595.487458-1567052119', '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 08:57:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:57:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:57:07 INFO - Using env: {'DISPLAY': ':0', 08:57:07 INFO - 'HOME': '/home/cltbld', 08:57:07 INFO - 'LANG': 'en_US.UTF-8', 08:57:07 INFO - 'LANGUAGE': 'en_US:en', 08:57:07 INFO - 'LOGNAME': 'cltbld', 08:57:07 INFO - 'MAIL': '/var/mail/cltbld', 08:57:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:57:07 INFO - 'MOZ_NO_REMOTE': '1', 08:57:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:57:07 INFO - 'NO_EM_RESTART': '1', 08:57:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:57:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:57:07 INFO - 'PWD': '/builds/slave/test', 08:57:07 INFO - 'SHELL': '/bin/bash', 08:57:07 INFO - 'SHLVL': '1', 08:57:07 INFO - 'TERM': 'linux', 08:57:07 INFO - 'TMOUT': '86400', 08:57:07 INFO - 'USER': 'cltbld', 08:57:07 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1448038595.487458-1567052119', 08:57:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:57:07 INFO - '_': '/tools/buildbot/bin/python'} 08:57:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:57:07 INFO - Downloading/unpacking blobuploader==1.2.4 08:57:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:57:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:57:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:57:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:57:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:57:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:57:09 INFO - Downloading blobuploader-1.2.4.tar.gz 08:57:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 08:57:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:57:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:57:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:57:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:57:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:57:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:57:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:57:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:57:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 08:57:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:57:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:57:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:57:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:57:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:57:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:57:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:57:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:57:09 INFO - Downloading docopt-0.6.1.tar.gz 08:57:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 08:57:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:57:09 INFO - Installing collected packages: blobuploader, requests, docopt 08:57:09 INFO - Running setup.py install for blobuploader 08:57:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:57:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:57:09 INFO - Running setup.py install for requests 08:57:10 INFO - Running setup.py install for docopt 08:57:10 INFO - Successfully installed blobuploader requests docopt 08:57:10 INFO - Cleaning up... 08:57:10 INFO - Return code: 0 08:57:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:57:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:57:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:57:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:57:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:57:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f249db02c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208a6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x213b900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2181b70>, '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 0x21d2dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d3250>, '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': '76a4ffbc7ba64825c1a171dc000001de-1448038595.487458-1567052119', '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 08:57:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:57:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:57:10 INFO - Using env: {'DISPLAY': ':0', 08:57:10 INFO - 'HOME': '/home/cltbld', 08:57:10 INFO - 'LANG': 'en_US.UTF-8', 08:57:10 INFO - 'LANGUAGE': 'en_US:en', 08:57:10 INFO - 'LOGNAME': 'cltbld', 08:57:10 INFO - 'MAIL': '/var/mail/cltbld', 08:57:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:57:10 INFO - 'MOZ_NO_REMOTE': '1', 08:57:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:57:10 INFO - 'NO_EM_RESTART': '1', 08:57:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:57:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:57:10 INFO - 'PWD': '/builds/slave/test', 08:57:10 INFO - 'SHELL': '/bin/bash', 08:57:10 INFO - 'SHLVL': '1', 08:57:10 INFO - 'TERM': 'linux', 08:57:10 INFO - 'TMOUT': '86400', 08:57:10 INFO - 'USER': 'cltbld', 08:57:10 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1448038595.487458-1567052119', 08:57:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:57:10 INFO - '_': '/tools/buildbot/bin/python'} 08:57:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:57:10 INFO - Running setup.py (path:/tmp/pip-EZrlfZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:57:10 INFO - Running setup.py (path:/tmp/pip-NN6ovS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:57:10 INFO - Running setup.py (path:/tmp/pip-BIzCrz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:57:10 INFO - Running setup.py (path:/tmp/pip-3k13rR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:57:10 INFO - Running setup.py (path:/tmp/pip-P6cRRR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:57:10 INFO - Running setup.py (path:/tmp/pip-hcIdMh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:57:11 INFO - Running setup.py (path:/tmp/pip-29FDGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:57:11 INFO - Running setup.py (path:/tmp/pip-jAi2ty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:57:11 INFO - Running setup.py (path:/tmp/pip-KswpW0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:57:11 INFO - Running setup.py (path:/tmp/pip-fRqYvy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:57:11 INFO - Running setup.py (path:/tmp/pip-erwGjW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:57:11 INFO - Running setup.py (path:/tmp/pip-3YCWP3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:57:11 INFO - Running setup.py (path:/tmp/pip-ZVQDrW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:57:11 INFO - Running setup.py (path:/tmp/pip-r7IfHc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:57:11 INFO - Running setup.py (path:/tmp/pip-2DuHyu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:57:11 INFO - Running setup.py (path:/tmp/pip-vuZKtT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:57:11 INFO - Running setup.py (path:/tmp/pip-eBNYSw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:57:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:57:11 INFO - Running setup.py install for manifestparser 08:57:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:57:11 INFO - Running setup.py install for mozcrash 08:57:12 INFO - Running setup.py install for mozdebug 08:57:12 INFO - Running setup.py install for mozdevice 08:57:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:57:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:57:12 INFO - Running setup.py install for mozfile 08:57:12 INFO - Running setup.py install for mozhttpd 08:57:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:57:12 INFO - Running setup.py install for mozinfo 08:57:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:57:12 INFO - Running setup.py install for mozInstall 08:57:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:57:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:57:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:57:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:57:12 INFO - Running setup.py install for mozleak 08:57:12 INFO - Running setup.py install for mozlog 08:57:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:57:12 INFO - Running setup.py install for moznetwork 08:57:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:57:12 INFO - Running setup.py install for mozprocess 08:57:13 INFO - Running setup.py install for mozprofile 08:57:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:57:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:57:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:57:13 INFO - Running setup.py install for mozrunner 08:57:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:57:13 INFO - Running setup.py install for mozscreenshot 08:57:13 INFO - Running setup.py install for moztest 08:57:13 INFO - Running setup.py install for mozversion 08:57:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:57:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:57:13 INFO - Cleaning up... 08:57:13 INFO - Return code: 0 08:57:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:57:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:57:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:57:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:57:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:57:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f249db02c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208a6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x213b900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2181b70>, '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 0x21d2dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d3250>, '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': '76a4ffbc7ba64825c1a171dc000001de-1448038595.487458-1567052119', '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 08:57:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:57:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:57:13 INFO - Using env: {'DISPLAY': ':0', 08:57:13 INFO - 'HOME': '/home/cltbld', 08:57:13 INFO - 'LANG': 'en_US.UTF-8', 08:57:13 INFO - 'LANGUAGE': 'en_US:en', 08:57:13 INFO - 'LOGNAME': 'cltbld', 08:57:13 INFO - 'MAIL': '/var/mail/cltbld', 08:57:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:57:13 INFO - 'MOZ_NO_REMOTE': '1', 08:57:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:57:13 INFO - 'NO_EM_RESTART': '1', 08:57:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:57:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:57:13 INFO - 'PWD': '/builds/slave/test', 08:57:13 INFO - 'SHELL': '/bin/bash', 08:57:13 INFO - 'SHLVL': '1', 08:57:13 INFO - 'TERM': 'linux', 08:57:13 INFO - 'TMOUT': '86400', 08:57:13 INFO - 'USER': 'cltbld', 08:57:13 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1448038595.487458-1567052119', 08:57:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:57:13 INFO - '_': '/tools/buildbot/bin/python'} 08:57:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:57:13 INFO - Running setup.py (path:/tmp/pip-yoPUJm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:57:13 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:57:13 INFO - Running setup.py (path:/tmp/pip-iVXIDy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:57:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:57:13 INFO - Running setup.py (path:/tmp/pip-HcHkXI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:57:14 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)) 08:57:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:57:14 INFO - Running setup.py (path:/tmp/pip-hygFgp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:57:14 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)) 08:57:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:57:14 INFO - Running setup.py (path:/tmp/pip-TvV6LS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:57:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:57:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:57:14 INFO - Running setup.py (path:/tmp/pip-yb90LW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:57:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:57:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:57:14 INFO - Running setup.py (path:/tmp/pip-PIFO5x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:57:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:57:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:57:14 INFO - Running setup.py (path:/tmp/pip-p6wMFH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:57:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:57:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:57:14 INFO - Running setup.py (path:/tmp/pip-kBadqN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:57:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:57:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:57:14 INFO - Running setup.py (path:/tmp/pip-JPHwba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:57:14 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)) 08:57:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:57:14 INFO - Running setup.py (path:/tmp/pip-afTzen-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:57:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:57:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:57:14 INFO - Running setup.py (path:/tmp/pip-VoxyDX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:57:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:57:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:57:14 INFO - Running setup.py (path:/tmp/pip-pppqyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:57:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:57:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:57:14 INFO - Running setup.py (path:/tmp/pip-m91ecT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:57:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:57:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:57:14 INFO - Running setup.py (path:/tmp/pip-ZTimPX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:57:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:57:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:57:14 INFO - Running setup.py (path:/tmp/pip-I723_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:57:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:57:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:57:14 INFO - Running setup.py (path:/tmp/pip-wk2CR4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:57:15 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)) 08:57:15 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)) 08:57:15 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)) 08:57:15 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)) 08:57:15 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)) 08:57:15 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)) 08:57:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:57:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:57:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:57:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:57:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:57:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:57:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:57:16 INFO - Downloading blessings-1.5.1.tar.gz 08:57:16 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 08:57:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:57:16 INFO - Installing collected packages: blessings 08:57:16 INFO - Running setup.py install for blessings 08:57:16 INFO - Successfully installed blessings 08:57:16 INFO - Cleaning up... 08:57:16 INFO - Return code: 0 08:57:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:57:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:57:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:57:17 INFO - Reading from file tmpfile_stdout 08:57:17 INFO - Current package versions: 08:57:17 INFO - argparse == 1.2.1 08:57:17 INFO - blessings == 1.5.1 08:57:17 INFO - blobuploader == 1.2.4 08:57:17 INFO - docopt == 0.6.1 08:57:17 INFO - manifestparser == 1.1 08:57:17 INFO - mozInstall == 1.12 08:57:17 INFO - mozcrash == 0.16 08:57:17 INFO - mozdebug == 0.1 08:57:17 INFO - mozdevice == 0.47 08:57:17 INFO - mozfile == 1.2 08:57:17 INFO - mozhttpd == 0.7 08:57:17 INFO - mozinfo == 0.9 08:57:17 INFO - mozleak == 0.1 08:57:17 INFO - mozlog == 3.0 08:57:17 INFO - moznetwork == 0.27 08:57:17 INFO - mozprocess == 0.22 08:57:17 INFO - mozprofile == 0.27 08:57:17 INFO - mozrunner == 6.11 08:57:17 INFO - mozscreenshot == 0.1 08:57:17 INFO - mozsystemmonitor == 0.0 08:57:17 INFO - moztest == 0.7 08:57:17 INFO - mozversion == 1.4 08:57:17 INFO - psutil == 3.1.1 08:57:17 INFO - requests == 1.2.3 08:57:17 INFO - wsgiref == 0.1.2 08:57:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:57:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:57:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:57:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:57:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:57:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f249db02c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208a6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x213b900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2181b70>, '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 0x21d2dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d3250>, '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': '76a4ffbc7ba64825c1a171dc000001de-1448038595.487458-1567052119', '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 08:57:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:57:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:57:17 INFO - Using env: {'DISPLAY': ':0', 08:57:17 INFO - 'HOME': '/home/cltbld', 08:57:17 INFO - 'LANG': 'en_US.UTF-8', 08:57:17 INFO - 'LANGUAGE': 'en_US:en', 08:57:17 INFO - 'LOGNAME': 'cltbld', 08:57:17 INFO - 'MAIL': '/var/mail/cltbld', 08:57:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:57:17 INFO - 'MOZ_NO_REMOTE': '1', 08:57:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:57:17 INFO - 'NO_EM_RESTART': '1', 08:57:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:57:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:57:17 INFO - 'PWD': '/builds/slave/test', 08:57:17 INFO - 'SHELL': '/bin/bash', 08:57:17 INFO - 'SHLVL': '1', 08:57:17 INFO - 'TERM': 'linux', 08:57:17 INFO - 'TMOUT': '86400', 08:57:17 INFO - 'USER': 'cltbld', 08:57:17 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1448038595.487458-1567052119', 08:57:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:57:17 INFO - '_': '/tools/buildbot/bin/python'} 08:57:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:57:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:57:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:57:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:57:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:57:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:57:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:57:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:57:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:57:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:57:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:57:17 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:57:17 INFO - Cleaning up... 08:57:17 INFO - Return code: 0 08:57:17 INFO - Running post-action listener: _resource_record_post_action 08:57:17 INFO - Running post-action listener: _start_resource_monitoring 08:57:17 INFO - Starting resource monitoring. 08:57:17 INFO - ##### 08:57:17 INFO - ##### Running install step. 08:57:17 INFO - ##### 08:57:17 INFO - Running pre-action listener: _resource_record_pre_action 08:57:17 INFO - Running main action method: install 08:57:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:57:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:57:17 INFO - Reading from file tmpfile_stdout 08:57:17 INFO - Detecting whether we're running mozinstall >=1.0... 08:57:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:57:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:57:17 INFO - Reading from file tmpfile_stdout 08:57:17 INFO - Output received: 08:57:17 INFO - Usage: mozinstall [options] installer 08:57:17 INFO - Options: 08:57:17 INFO - -h, --help show this help message and exit 08:57:17 INFO - -d DEST, --destination=DEST 08:57:17 INFO - Directory to install application into. [default: 08:57:17 INFO - "/builds/slave/test"] 08:57:17 INFO - --app=APP Application being installed. [default: firefox] 08:57:17 INFO - mkdir: /builds/slave/test/build/application 08:57:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:57:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:57:31 INFO - Reading from file tmpfile_stdout 08:57:31 INFO - Output received: 08:57:31 INFO - /builds/slave/test/build/application/firefox/firefox 08:57:31 INFO - Running post-action listener: _resource_record_post_action 08:57:31 INFO - ##### 08:57:31 INFO - ##### Running run-tests step. 08:57:31 INFO - ##### 08:57:31 INFO - Running pre-action listener: _resource_record_pre_action 08:57:31 INFO - Running main action method: run_tests 08:57:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:57:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:57:31 INFO - Python 2.7.3 08:57:31 INFO - Return code: 0 08:57:31 INFO - grabbing minidump binary from tooltool 08:57:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:57:31 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2181b70>, '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 0x21d2dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d3250>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:57:31 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:57:31 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:57:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:57:31 INFO - Return code: 0 08:57:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:57:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:57:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:57:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:57:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:57:31 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/uaCOO9oFQL-duv7raIGe1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost'] in /builds/slave/test/build 08:57:31 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/uaCOO9oFQL-duv7raIGe1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --webServer localhost 08:57:31 INFO - Using env: {'DISPLAY': ':0', 08:57:31 INFO - 'HOME': '/home/cltbld', 08:57:31 INFO - 'LANG': 'en_US.UTF-8', 08:57:31 INFO - 'LANGUAGE': 'en_US:en', 08:57:31 INFO - 'LOGNAME': 'cltbld', 08:57:31 INFO - 'MAIL': '/var/mail/cltbld', 08:57:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:57:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:57:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:57:31 INFO - 'MOZ_NO_REMOTE': '1', 08:57:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:57:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:57:31 INFO - 'NO_EM_RESTART': '1', 08:57:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:57:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:57:31 INFO - 'PWD': '/builds/slave/test', 08:57:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:57:31 INFO - 'SHELL': '/bin/bash', 08:57:31 INFO - 'SHLVL': '1', 08:57:31 INFO - 'TERM': 'linux', 08:57:31 INFO - 'TMOUT': '86400', 08:57:31 INFO - 'USER': 'cltbld', 08:57:31 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1448038595.487458-1567052119', 08:57:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:57:31 INFO - '_': '/tools/buildbot/bin/python'} 08:57:31 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/uaCOO9oFQL-duv7raIGe1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost'] with output_timeout 3600 08:57:32 INFO - mozversion INFO | application_buildid: 20151120082241 08:57:32 INFO - mozversion INFO | application_changeset: 1f9d9bfafd5143618083adcd50f5fcb0fead5530 08:57:32 INFO - mozversion INFO | application_display_name: Nightly 08:57:32 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:57:32 INFO - mozversion INFO | application_name: Firefox 08:57:32 INFO - mozversion INFO | application_remotingname: firefox 08:57:32 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 08:57:32 INFO - mozversion INFO | application_vendor: Mozilla 08:57:32 INFO - mozversion INFO | application_version: 45.0a1 08:57:32 INFO - mozversion INFO | platform_buildid: 20151120082241 08:57:32 INFO - mozversion INFO | platform_changeset: 1f9d9bfafd5143618083adcd50f5fcb0fead5530 08:57:32 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 08:57:32 INFO - mozversion INFO | platform_version: 45.0a1 08:57:32 INFO - 2015-11-20 08:57:32,112 DEBUG : using testdate: 1448038652 08:57:32 INFO - 2015-11-20 08:57:32,112 DEBUG : actual date: 1448038652 08:57:32 INFO - 2015-11-20 08:57:32,125 INFO : starting webserver on 'localhost:33984' 08:57:32 INFO - 2015-11-20 08:57:32,126 INFO : Starting test suite talos-linux64-ix-011 08:57:32 INFO - 2015-11-20 08:57:32,126 INFO : Starting test dromaeo_css 08:57:32 INFO - 2015-11-20 08:57:32,126 DEBUG : operating with platform_type : linux_ 08:57:32 INFO - 2015-11-20 08:57:32,127 INFO : Initialising browser for dromaeo_css test... 08:57:32 INFO - 2015-11-20 08:57:32,143 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi111tO/profile http://localhost:33984/getInfo.html 08:57:37 INFO - 2015-11-20 08:57:37,356 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:57:37 INFO - 2015-11-20 08:57:37,356 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:57:37 INFO - 2015-11-20 08:57:37,356 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:57:37 INFO - 2015-11-20 08:57:37,357 DEBUG : BROWSER_OUTPUT: __metrics 08:57:37 INFO - 2015-11-20 08:57:37,546 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:57:39 INFO - 2015-11-20 08:57:39,165 INFO : Browser initialized. 08:57:39 INFO - 2015-11-20 08:57:39,165 INFO : Running cycle 1/1 for dromaeo_css test... 08:57:39 INFO - 2015-11-20 08:57:39,166 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi111tO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:57:51 INFO - 2015-11-20 08:57:51,068 DEBUG : BROWSER_OUTPUT: RSS: Main: 142270464 08:57:51 INFO - 2015-11-20 08:57:51,068 DEBUG : BROWSER_OUTPUT: 08:58:42 INFO - 2015-11-20 08:58:42,394 DEBUG : BROWSER_OUTPUT: 1448038722393 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:00:54 INFO - 2015-11-20 09:00:54,743 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33984/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33984/tests/dromaeo/cssquery-ext.html) 09:00:55 INFO - 2015-11-20 09:00:55,834 DEBUG : BROWSER_OUTPUT: RSS: Main: 240279552 09:00:55 INFO - 2015-11-20 09:00:55,834 DEBUG : BROWSER_OUTPUT: 09:03:58 INFO - 2015-11-20 09:03:58,422 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33984/tests/dromaeo/cssquery-ext.html (next: http://localhost:33984/tests/dromaeo/cssquery-jquery.html) 09:03:58 INFO - 2015-11-20 09:03:58,991 DEBUG : BROWSER_OUTPUT: RSS: Main: 221073408 09:03:58 INFO - 2015-11-20 09:03:58,991 DEBUG : BROWSER_OUTPUT: 09:07:01 INFO - 2015-11-20 09:07:01,175 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33984/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33984/tests/dromaeo/cssquery-mootools.html) 09:07:01 INFO - 2015-11-20 09:07:01,741 DEBUG : BROWSER_OUTPUT: RSS: Main: 218066944 09:07:01 INFO - 2015-11-20 09:07:01,741 DEBUG : BROWSER_OUTPUT: 09:10:03 INFO - 2015-11-20 09:10:03,676 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33984/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33984/tests/dromaeo/cssquery-prototype.html) 09:10:04 INFO - 2015-11-20 09:10:04,262 DEBUG : BROWSER_OUTPUT: RSS: Main: 202588160 09:10:04 INFO - 2015-11-20 09:10:04,262 DEBUG : BROWSER_OUTPUT: 09:13:06 INFO - 2015-11-20 09:13:06,949 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33984/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33984/tests/dromaeo/cssquery-yui.html) 09:13:07 INFO - 2015-11-20 09:13:07,543 DEBUG : BROWSER_OUTPUT: RSS: Main: 182657024 09:13:07 INFO - 2015-11-20 09:13:07,543 DEBUG : BROWSER_OUTPUT: 09:16:10 INFO - 2015-11-20 09:16:10,114 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33984/tests/dromaeo/cssquery-yui.html (next: http://localhost:33984/tests/dromaeo/cssquery-dojo.html) 09:16:10 INFO - 2015-11-20 09:16:10,364 DEBUG : BROWSER_OUTPUT: RSS: Main: 261636096 09:16:10 INFO - 2015-11-20 09:16:10,364 DEBUG : BROWSER_OUTPUT: 09:16:10 INFO - 2015-11-20 09:16:10,365 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:16:10 INFO - 2015-11-20 09:16:10,365 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:16:10 INFO - 2015-11-20 09:16:10,365 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:16:10 INFO - 2015-11-20 09:16:10,365 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:16:10 INFO - 2015-11-20 09:16:10,366 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2681.772049375803;2785.7353551412607;2790.5814127880826;2799.6640403151614;2802.1033269353807;4536.6370690344775;4653.0228651983125;4800.231962885939;4829.154897892868;4845.055214233226;4699.271612899997;4713.387259656249;4806.20697584899;4817.132916075105;4835.661503694742;4407.382966384709;4467;4474.463064432272;4489.214387482178;4490.910181796362;4248.490181178263;4533.607375303455;4583.175028494869;4640.373549570799;4644.790984405693;4326.935095973563;4389.692721509479;4422.04925940921;4424.867253982354;4437.0682156747125;4469.508354081048;4474.373587697725;4474.731516109011;4479.552044795527;4512.593866552026;4171.6036976487185;4452.287633978548;4455.242608756519;4471.955280447187;4496.4829044659955;4615.515370886043;4626.861194164147;4649.279361698942;4713.858584242478;4766.833160839354;5128.769205385729;5131.281620573122;5133.845984620468;5159;5172.431032586413;4863.927041094386;5157.71632560209;5159.380874295071;5168.22476628505;5192.662476938987;4760.857174284777;4770.165221086296;4785.784639691187;4795.688280261772;4861.611071114302;5317.14925611908;5393.8112166074;5396.4333744957;5400.351957765093;5441.619086663895;4867.172580661296;5156.690598564098;5175.094358487249;5180.637355385163;5223.947760522422;4996.525330093636;4996.825111121166;5006.549410553068;5038.193888977819;5145.974270128625;5025.673331233531;5106.846794596168;5146.202338637442;5147.459516750687;5154.587632989352;5128.769205385766;5131.281620573122;5131.846044618667;5136.152534831711;5136.383633963948;4139.627433530996;4244.660427165819;4244.893877653083;4279.079997800488;4353.564643535685;3797.5632802227547;3828.8468461261236;3833.8466461341236;3860.4402361657963;3888.863889763845;4397.428334316518;4434.467863856358;4435.512093669694;4446.644268458515;4474.038081812426;4882.462929077798;4982.402111746541;4992.975035124874;5177.663451875616;5256.08018596744;4369.9126017479475;4424.6902716810155;4442.666799990014;4484.708493947883;4490.640748740093;4652.930206046912;4657.0685862826895;4674.929876051862;4687.226607609706;4688.648351373592;4696.38946936896;4837.516248375135;4838.709677419366;4906.607471402351;4932.90134197314;5039.496050394931;5186.222066689876;5281.075811732854;5333.173358129496;5338.893222135458;4909.754512274443;4931.753412329297;4933.210686290176;4935.703857768545;4974;5099.69401835891;5105.5149760772665;5112.539871411591;5128.615353848401;5142.1772516397195;4886.65793394459;5023.1711767557945;5066.6200034998255;5067.543921047123;5076.923846142385;5077.466865979019;5111.744412779271;5113.347868940481;5113.616478764033;5116.692998420107;5077;5083.110455670169;5089.185730283137;5090.592752579859;5110.974445127899;4689.507601701772;4808.110499557453;4810.542998415145;4854.1747902857305;4951.257311403318;5096.877637973813;5150.587952963679;5153.072446959583;5155.845324640267;5203.401608815035;4989.525995030466;5006.574441172541;5017.781701556575;5027.59779217669;5071.568916642127 09:16:10 INFO - 2015-11-20 09:16:10,368 DEBUG : BROWSER_OUTPUT: |1;ext.html;557.6431084106173;559.8180591307826;563.0372063770955;565.3865555871879;578.965262084275;27707.168784936435;28181.29546761332;28216.294592635193;28263.57604635932;28298.292542686442;30144.849275753644;30656.540151897683;37589.62410375896;39021.41467877984;39038.804805976004;7906.130325664172;8050.557219352933;8055.718049868256;8056;8069.072056713465;7166.713331466735;7880.211978802103;7966.6415011324625;8003.51978881266;8012.238837310446;7115.2884711528695;10188.847167292497;10455.84316235257;10462.110720588758;10468.371897686126;9857.95071024644;9910.058544438267;9946.20430365569;9955.701328960144;9979.251556133318;7174.461915356369;7355.668994895243;9627.56675949584;9742.07450292221;10134.847977280348;38043.619563804285;38541.80729096365;38575.42136867949;38639;38706.225875482334;2886.5092934201234;2905.375344300964;2970.55441683747;3204.7756657034015;3423.7432192585657;29065.564016539767;29239.2690182745;29241.85379073091;29606.555901661275;30139.397212055635;3511.3855075361967;3529.082438565991;3577.123604716835;3590;3623.800690961996;328687;331042;331435;332539.99999999756;333185;56835.71582142063;57717.71141144267;57817.132743008886;57832.3975421107;57858.710706446196;61665;62005.37994619996;62064;62093.379066209665;62126;13038.608841734764;13239.338033098307;13252.403641836141;13319.134256273312;13431.932840335736;10031.749206269902;10065.144462720751;10082.04220599042;10084.546195421224;10092.646757363456;19442.611147777247;19876.50308742264;19916.402507924784;19924.800751992585;19958.30145944885;7807.6486558105025;7982.321502672222;7985.361171106298;8026.558539280279;8041.3164880984605;839.7312859884778;856.6188046319328;863.1842908451453;885.9955700221586;982.3025651787168;26723.19830405091;26794.732052679225;27099.729002710115;27169.184924452296;27205;874.1171416868881;944.4899754132829;947.2138125355938;996.3722854601555;1022.2844009193594;12977.35113244334;15757.527274181793;16397.91801041011;16463.588410289598;16622.168891555375;325100;330577;331633;332620;333297;47130;48246.5175348249;54359.45640543544;55712.72143639337;55761.721191394594;1215.6899990502366;1219.71336735867;1221.4625564751482;1245.2341809786915;1260.8676089010705;24092.87953560221;26224.475510490065;27312.863435682695;29238.561421579117;30448.238794030327;44393;45244.77377613091;45305.546944530135;45345.54654453413;45396.31905521486;247225;250406;250676;251093;251270;40199.3970090443;40392.79803600963;40429.59570404376;40859.59140408558;40961.59038409697;41280;42344;42957.57042429536;43345.133097338505;43377;34454.621815128114;34836.129096772784;35312.82343588266;38220.61779382282;39982.2003559933;34342;38066.80966595149;39801;40207.79896100618;40530.79734601308;34872.30255394827;34910.47634285437;34911;35319.82340088283;35473.82263088668;30462.695373046874;31582.842085789423;31873.36253274875;32043.198920026254;32082.51876221812;24259.878700606383;24451.51096978015;24625.87687061553;24936.625950610392;24987.125450609143 09:16:10 INFO - 2015-11-20 09:16:10,371 DEBUG : BROWSER_OUTPUT: |2;jquery.html;322.74241679452234;327.8426355349432;338.52268301694613;342.209496064092;343.3407856914723;12439.875601243984;12813.487460501568;15468.535943921686;16056.83943160568;16832.410865619706;13731;13832;14140.92929535351;14149.57551273461;14160;4889.095517329288;4920.040592084554;4958.206686930092;4988.501149885019;5059.671121377117;3608.332458495174;3766.6986641068647;5699.2590963174935;5935.851603709899;5940.910886336708;5783.681897495636;5866.735996880129;5869.148973398855;5871.089981052944;5894.115882617599;5799.855003624901;5869.530437564985;5879.206307148523;5879.618289701916;5886.440788125121;5051.06555287273;5120.718360490171;5145.948540514584;5146.562542183919;5147.536721695028;19247.23011079555;19397.903010485;19581.314653987185;19682;19731.309404170785;1809.3215044358365;1847.29802674984;1873.363056560776;1952.0727654364205;1994.58113796103;12418.130730848845;12540;12713.809292860615;12812.16720913147;13093.934530327382;1757.2531674038482;1770.663573920951;1779.146009915248;1796.793368762596;1826.4429349048535;52824.47175528234;53690.19464707994;54549.454505454836;55173;55635.44364556343;9209.907900920905;9341.813163736688;9506.524673766422;9585.760355991017;9608.2793790466;12001.699957501132;12075.516979320904;12142;12149.271043737228;12155.696107597381;6809.659517024129;6834.692438840264;6951.826204344932;7002.509824312351;7023.438124949992;6348.301686814447;6393.424591786761;6416.967915160488;6432.35676432353;6434.9678251609375;5652.858678532987;5726.885462290731;5728.140778883201;5748.7125643717645;5861.73972595894;1475.2623688155923;1631.7633943078188;1642.1789105447276;1689.5691598642513;1692.678391105686;359.8632519642519;364.22056798451337;403.9454673619024;819.1521774963004;851.4635779458902;9345.682342714988;10026;10062.74843128913;10069.69790906274;10278.434686092187;378.3586820339553;400.96591789698203;408.573041171976;414.4094665102217;429.18026569253203;4603.562661547147;5361.892762144736;5420.13277875538;5470.17947307907;5470.753816078286;451582;452188;459674;461094;463320;69119;71499.64250178715;71591;72185.63907180431;72308;458.8027148326185;461.19981831522284;461.98614041578804;463.0715415591717;463.9466461356987;9436.622535098519;9595;9668.274879384215;9813.11681948628;9860.506974651382;31871.36257274888;32111.197220069684;32703.34593308168;33218.66781332252;33540.329193415506;42432;42975.355369670106;43096.35355469733;44090.338644920994;44124.55875441333;8426.957865210634;8861.33539984491;8883.333749968908;8949.105089490999;8956.193942545202;10222.539985700512;11490.82763758561;15482;15545.533633990999;15637.687246254784;12737.172083814523;13061.673458163621;13167.209967401986;13461.326933653474;13473.797893031417;2285.3943704918543;10172.949135254275;12818.423170957516;13483.896699571322;13901.16593004423;10425.53085111187;13331.400086996302;13797.931010344884;13994.930025349808;14418.639534011314;7167.462440316893;8721.520316382406;8858.158474945129;8865.24645405122;8900.910990890266;11169.553217871195;13087.738245235232;13104.475820967054;13356.465741370237;13608.455661773418 09:16:10 INFO - 2015-11-20 09:16:10,373 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1443.9494617688383;1646.6953613581486;1682.6045879218382;1727.4558514068067;1727.4817554733577;6128.877422451548;6832.419244364229;7004.57972521649;7004.64976751163;7013.43892488601;6964.547304425221;6997.545159564625;7009.053777740003;7073.610951397671;7074.434045276378;2084.541400891805;2098.7481502219757;2102.8317734581196;2104.084723145437;2105.8631188972668;2077.45986043629;2084.895755212241;2095.025812996956;2120.7773183815707;2129.3931229599566;2064.5354795171042;2079.8336133109315;2088.1229883448987;2090.644590419625;2093.3510611710344;2108.7891210878943;2120.692499587551;2121.374194612585;2124.9256276030264;2125.9468513287216;2077.1379877350882;2115.6509175985943;2117.76704562498;2119.3218170185546;2123.6814477828293;5972.880542389172;6169.537284703665;7016.929830701679;7049.7885063448175;7057.047298614672;3978.0651546886456;4101.815418306153;4106.07613287011;4108.424820525129;4110.609492098246;2739.2877851758685;2754.4353407551403;2799;2799.958000629992;2816.915492535207;877.0440220159992;880.4409200157882;888.8888888888889;893.1782759860944;893.3389291923929;9592.856107158399;9705.805883882284;9707.757306067335;9732.854007189828;9738.9513052435;4043.8786836394956;4060.045889216032;4095.9350568852315;4102.425660407545;4107.260693075275;8427.452215605967;8444.324454043663;8447.873281900776;8451.45065570736;8452.02801677815;4187.832486700498;4219.198352313051;4219.767912764827;4223.915521689549;4226.408302837605;3833.559140698855;3841.1741475582326;3843.7885916274313;3846.9805501542114;3852.9422058669143;3313.3042061167425;3324.3185147044796;3337.1657085728566;3352.8826491072696;3353.480210567366;1057.2599180573475;1058.6823952814125;1060.2472244706191;1063.2769716592636;1066.6693325069252;878.1657425445725;880.1946219209352;892.2237653241591;892.3931726426092;1037.9273450858518;6568.441682457044;6609.768658096944;6617.702203400859;6622.4702023838945;6634.767783127664;424.4651738809123;433.29589417197053;437.8992831648675;437.94525684289465;439.5077513185253;4859.416869975555;5245.816396426107;5321.521063104262;5325.840224793263;5345.4654534546235;7498;8355.122712115262;8428.157184281523;8539.359548033797;8540.060593334729;8281;8367.372447066495;8396.286315663116;8404.24361807428;8409.663613455516;6518.250401203827;6632.237292711304;6685.465162786965;6692.631905245258;6704;6398.296187419287;6426.710798014195;6431.5819471734185;6450.129232553733;6505.447037001719;7229.566226026455;7412.851742965218;7423.962880185564;7519.661615227437;7549.584772837547;7691.769246922601;7802.180771018961;7960.681572737026;7972.800679983046;7980.720674776355;5754.6547207167705;5985.790497332572;6047.485963693135;6275.246970363585;6298.370162983665;6713.63075030878;6746.8650626988165;6748.223954245128;6750.2237242715755;6752.527323087336;6387.169667943138;6425.293217745951;6465.353464653497;6502.414782669583;6529.967350163219;6354.205724284465;6371.203599550056;6431.614103153825;6441.806745797634;6456.192975878015;6232.096346029891;6257.311695713377;6270.4670103039925;6274.027525733519;6279.434850863444;5761.539076873756;5789.507891829242;5821.76712931478;5828.0966450200285;5978.850528736642;6110.297315808739;6111.297200821785;6129.570930034854;6150.200473938359;6184.257889053342 09:16:10 INFO - 2015-11-20 09:16:10,374 DEBUG : BROWSER_OUTPUT: |4;prototype.html;301.34307210281594;310.6194911233739;312.28175197046795;312.6888745698031;314.46540880503153;5332.066888294552;5445.373782015069;5507.311586051744;5514.751836167372;5516.255305533752;5402.108652072413;5410.377806552247;5410.594205434599;5411.485908838664;5414.998225328307;4076.6331030207275;4147.294959856817;4236.385724070008;4243.469566304212;4251.5535868733805;4146.336586146217;4166.812493437803;4272.679549033819;4279.165562715256;4293.549177336382;4201.411802347674;4231.736021228643;4240.279152544075;4246.299360605496;4251.936220956688;4021.537523184842;4140.130572579762;4232.978835105836;4239.915201695964;4250.043740158486;3677.411614141751;3746.194568167857;3755.830987605564;3766.472693822867;3771;5199.324087868553;5209.661372010845;5210.843674689765;5213.921791173136;5215;4858.1012512685265;4878.682885612424;4888.388951381077;4889.997550502174;4893.828715994959;5602.1596760485845;5709.25779648643;5716.114002329646;5721.227634269362;5733.111367737965;4090.6931980101313;4091.89770255743;4096.242195193869;4096.610821971908;4106.014556506447;5989.460948514611;6011.729472173719;6016.759329626766;6017.157597936292;6017.217761690996;4216.2199993001395;4217.093324935092;4218.409422680827;4220.430241917364;4220.577942205816;3994.360902255625;4113.753174809521;4280.464941882265;4282.614564689193;4286.914261714748;4720.457147428021;4742.834000809955;4769.952300476951;4773.832915847928;4775.188218002948;5731.885362292731;5739.971300143473;5746.166805813134;5748.942510574924;5750.108733146369;1452.3028946105928;1474.3660226102663;1475.4098360655823;1475.527831094061;1477.4016523308078;990.9256805739599;992.5186284651938;993.011953106649;1006.1296978113879;1011.231464087299;4982.626303027288;5009.148444764399;5010.824621138243;5018.874528136753;5020.347354843847;5929.703514824241;5930.822075337746;5933.643981361132;5935.821925342247;5940.8415359004575;4990.951900100947;4991.97664478781;4997.925446029121;5001.049800537959;5002.824901128443;3116.454620441459;3176.888808891678;3206.9679303206667;3209.8395080245896;3212.9718490083415;5586.106223004381;5589.273394458694;5593.021221286259;5600.243967064475;5603.243562119062;6085.847853803691;6093.299270583851;6097.634141951497;6101.511879049665;6110.144579758838;5476;5578.63738856973;5587.357453892773;5590.636608620427;5601.579881508903;5858.2677165354335;5923.466887980103;5926.881462370642;5939.613925094855;5947.494462970696;5801.1878337032;5806.303243610793;5807.854803629774;5810.215620891126;5813.128030795246;5590.496855283044;5598.496135347838;5600.663960162403;5604.411536788579;5607.130894711327;3998.9202915213314;4085.040015596392;4103;4106.67146628275;4111.362738775495;5901.439363260483;5904.232449781501;5906.114082887601;5922.170896074467;5925.496332811759;5690.2887139107615;5701.173329867063;5708.885822283448;5710.428957104256;5711.457411546063;5549.556035517068;5693.9430605693415;5701.572382071444;5702.429757024431;5708.058170401837;5567.7494512747835;5583;5585.609007369445;5588.077967135539;5591.245181900392;5544.889102217852;5697;5715.599908006399;5744.569157313302;5754.597178197486;5433.945660543344;5605.103183490622;5606.467385598362;5641.15382692583;5646.096624540054 09:16:10 INFO - 2015-11-20 09:16:10,374 DEBUG : BROWSER_OUTPUT: |5;yui.html;717.3113810741688;729.135973870963;757.1217387830117;797.397964536775;813.1868131868132;11023.61417350393;11231.60689375873;11448.771024579504;11784;11829.46767395467;12069.517219311218;12179.330136842493;12185;12188.085893557974;12198.329091899943;623.6476390839184;631.9368063193667;793.896793416855;798.2376830127243;812.5124925044985;811.0956283743612;811.4806523824727;816.4040250617053;816.6243527977108;816.967321307147;849.1847826086964;850.2390360627235;851.3657325292666;857.691231156783;857.9871301930476;647.1102234427661;658.8122385120241;842.7176895739934;867.5445391169624;870.499462808881;613.6962203709148;619.8295468746086;620.8354785981718;620.9906851397233;621.226572916717;11615.593454229145;11755.823662645067;11787;11803.586874459439;11812.232204906653;10436.530356133992;10500.2649814513;10882.891171088268;11427.714307142305;11876.881231187665;8150.75547733569;10021.39871607706;10095.394276343442;10293.536790844355;10303.896961030368;3200.7119359257777;3232.159638493985;3238.4494635911715;3246.088899925503;3297.0768184908266;40252.19495610071;40356.19287614261;40401.39397909034;41395.586044139476;42676.78661606672;9358.204552612968;9482.810343793086;9505.42967421957;9530.666426675032;9588.328816982745;16566.66866662684;16910.830891690926;16912.915435422743;16940.57648558796;16971.406000789913;6204.968975155186;6369.331220221903;6489.286178520359;6577.769778057841;6587.53887227899;3620.131168519589;3665.1020499977676;3665.706743460517;3674.3937250353392;3758.1356288053903;2689.784817214618;2696.474187533412;2702.8108032437935;2710.6611673540806;2724.9046283380385;491.6189952786619;494.0736119775421;497.34847349971653;500.47200203785354;507.1935622360391;573.5010540829421;583.4661284924332;593.4807043836643;638.4062821575978;638.4349850382445;7812.687492500237;8437.493750374997;8472.49165050099;8534.27458666008;8535.103814099555;501.7917564210812;612.6599737145926;628.5286035473395;640.5420124610926;640.5740182778493;3581.982090089533;3646.7447278690765;3698.4822124902535;3707.5550933888107;3741.2704522618374;52767.47232527703;53421.46578534243;53552;53795.46204537905;53916.730416347666;44493.77753111214;44769;44971.32543011857;45112.54887451084;46519.767401162775;40365.59634403618;40446.393304100464;40753;41050.79474602608;41085.58914410877;7237.529560578546;7302.707891684273;7337.413006959324;7439.55362678241;7576.3181313682035;30017.249568760082;30274.69725302719;30977;31136.22159446032;31314.843425782725;37596.812015939744;40811;41057.58942410657;41063;41355.379669305585;10136;10275.948620256851;10282.794344112926;10283.897161028293;10304.278700490893;10994.175436842108;11189.216754827085;11239.10087193039;11462.312261264351;11556;9932.851007235042;10176.135028522658;10248.180145588483;10278.948605256926;10504.054635082879;10580.89419105799;10832.5125369357;10962.780744385227;11134.3876086816;11238;10072.395656260647;10390.22073344487;10559.78880422372;10616.256862019893;10765.89234107649;8980.191782739323;9033.096690330914;9069.954650226706;9239.445633262027;9475.573599187916;8679.652813887626;8813.60338784769;8831.337649676429;8999;9020.368574199743 09:16:10 INFO - 2015-11-20 09:16:10,374 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:16:10 INFO - 2015-11-20 09:16:10,374 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:16:10 INFO - 2015-11-20 09:16:10,375 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,887 09:16:10 INFO - 2015-11-20 09:16:10,375 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:16:10 INFO - 2015-11-20 09:16:10,375 DEBUG : BROWSER_OUTPUT: __startTimestamp1448039770363__endTimestamp 09:16:10 INFO - 2015-11-20 09:16:10,375 DEBUG : BROWSER_OUTPUT: 09:16:10 INFO - 2015-11-20 09:16:10,375 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:16:10 INFO - 2015-11-20 09:16:10,375 DEBUG : BROWSER_OUTPUT: Number of tests: 6 09:16:10 INFO - 2015-11-20 09:16:10,375 DEBUG : BROWSER_OUTPUT: 09:16:10 INFO - 2015-11-20 09:16:10,375 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4761.87 Median:4863.93 stddev:495.50 (10.2%) stddev-sans-first:469.38 09:16:10 INFO - 2015-11-20 09:16:10,377 DEBUG : BROWSER_OUTPUT: Values: 2681.8 2785.7 2790.6 2799.7 2802.1 4536.6 4653.0 4800.2 4829.2 4845.1 4699.3 4713.4 4806.2 4817.1 4835.7 4407.4 4467.0 4474.5 4489.2 4490.9 4248.5 4533.6 4583.2 4640.4 4644.8 4326.9 4389.7 4422.0 4424.9 4437.1 4469.5 4474.4 4474.7 4479.6 4512.6 4171.6 4452.3 4455.2 4472.0 4496.5 4615.5 4626.9 4649.3 4713.9 4766.8 5128.8 5131.3 5133.8 5159.0 5172.4 4863.9 5157.7 5159.4 5168.2 5192.7 4760.9 4770.2 4785.8 4795.7 4861.6 5317.1 5393.8 5396.4 5400.4 5441.6 4867.2 5156.7 5175.1 5180.6 5223.9 4996.5 4996.8 5006.5 5038.2 5146.0 5025.7 5106.8 5146.2 5147.5 5154.6 5128.8 5131.3 5131.8 5136.2 5136.4 4139.6 4244.7 4244.9 4279.1 4353.6 3797.6 3828.8 3833.8 3860.4 3888.9 4397.4 4434.5 4435.5 4446.6 4474.0 4882.5 4982.4 4993.0 5177.7 5256.1 4369.9 4424.7 4442.7 4484.7 4490.6 4652.9 4657.1 4674.9 4687.2 4688.6 4696.4 4837.5 4838.7 4906.6 4932.9 5039.5 5186.2 5281.1 5333.2 5338.9 4909.8 4931.8 4933.2 4935.7 4974.0 5099.7 5105.5 5112.5 5128.6 5142.2 4886.7 5023.2 5066.6 5067.5 5076.9 5077.5 5111.7 5113.3 5113.6 5116.7 5077.0 5083.1 5089.2 5090.6 5111.0 4689.5 4808.1 4810.5 4854.2 4951.3 5096.9 5150.6 5153.1 5155.8 5203.4 4989.5 5006.6 5017.8 5027.6 5071.6 09:16:10 INFO - 2015-11-20 09:16:10,377 DEBUG : BROWSER_OUTPUT: 09:16:10 INFO - 2015-11-20 09:16:10,377 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:46835.55 Median:19420.95 stddev:80350.40 (413.7%) stddev-sans-first:80500.68 09:16:10 INFO - 2015-11-20 09:16:10,377 DEBUG : BROWSER_OUTPUT: Values: 557.6 559.8 563.0 565.4 579.0 27707.2 28181.3 28216.3 28263.6 28298.3 30144.8 30656.5 37589.6 39021.4 39038.8 7906.1 8050.6 8055.7 8056.0 8069.1 7166.7 7880.2 7966.6 8003.5 8012.2 7115.3 10188.8 10455.8 10462.1 10468.4 9858.0 9910.1 9946.2 9955.7 9979.3 7174.5 7355.7 9627.6 9742.1 10134.8 38043.6 38541.8 38575.4 38639.0 38706.2 2886.5 2905.4 2970.6 3204.8 3423.7 29065.6 29239.3 29241.9 29606.6 30139.4 3511.4 3529.1 3577.1 3590.0 3623.8 328687.0 331042.0 331435.0 332540.0 333185.0 56835.7 57717.7 57817.1 57832.4 57858.7 61665.0 62005.4 62064.0 62093.4 62126.0 13038.6 13239.3 13252.4 13319.1 13431.9 10031.7 10065.1 10082.0 10084.5 10092.6 19442.6 19876.5 19916.4 19924.8 19958.3 7807.6 7982.3 7985.4 8026.6 8041.3 839.7 856.6 863.2 886.0 982.3 26723.2 26794.7 27099.7 27169.2 27205.0 874.1 944.5 947.2 996.4 1022.3 12977.4 15757.5 16397.9 16463.6 16622.2 325100.0 330577.0 331633.0 332620.0 333297.0 47130.0 48246.5 54359.5 55712.7 55761.7 1215.7 1219.7 1221.5 1245.2 1260.9 24092.9 26224.5 27312.9 29238.6 30448.2 44393.0 45244.8 45305.5 45345.5 45396.3 247225.0 250406.0 250676.0 251093.0 251270.0 40199.4 40392.8 40429.6 40859.6 40961.6 41280.0 42344.0 42957.6 43345.1 43377.0 34454.6 34836.1 35312.8 38220.6 39982.2 34342.0 38066.8 39801.0 40207.8 40530.8 34872.3 34910.5 34911.0 35319.8 35473.8 30462.7 31582.8 31873.4 32043.2 32082.5 24259.9 24451.5 24625.9 24936.6 24987.1 09:16:10 INFO - 2015-11-20 09:16:10,377 DEBUG : BROWSER_OUTPUT: 09:16:10 INFO - 2015-11-20 09:16:10,377 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25012.35 Median:43035.85 stddev:74846.46 (173.9%) stddev-sans-first:75033.46 09:16:10 INFO - 2015-11-20 09:16:10,377 DEBUG : BROWSER_OUTPUT: Values: 322.7 327.8 338.5 342.2 343.3 12439.9 12813.5 15468.5 16056.8 16832.4 13731.0 13832.0 14140.9 14149.6 14160.0 4889.1 4920.0 4958.2 4988.5 5059.7 3608.3 3766.7 5699.3 5935.9 5940.9 5783.7 5866.7 5869.1 5871.1 5894.1 5799.9 5869.5 5879.2 5879.6 5886.4 5051.1 5120.7 5145.9 5146.6 5147.5 19247.2 19397.9 19581.3 19682.0 19731.3 1809.3 1847.3 1873.4 1952.1 1994.6 12418.1 12540.0 12713.8 12812.2 13093.9 1757.3 1770.7 1779.1 1796.8 1826.4 52824.5 53690.2 54549.5 55173.0 55635.4 9209.9 9341.8 9506.5 9585.8 9608.3 12001.7 12075.5 12142.0 12149.3 12155.7 6809.7 6834.7 6951.8 7002.5 7023.4 6348.3 6393.4 6417.0 6432.4 6435.0 5652.9 5726.9 5728.1 5748.7 5861.7 1475.3 1631.8 1642.2 1689.6 1692.7 359.9 364.2 403.9 819.2 851.5 9345.7 10026.0 10062.7 10069.7 10278.4 378.4 401.0 408.6 414.4 429.2 4603.6 5361.9 5420.1 5470.2 5470.8 451582.0 452188.0 459674.0 461094.0 463320.0 69119.0 71499.6 71591.0 72185.6 72308.0 458.8 461.2 462.0 463.1 463.9 9436.6 9595.0 9668.3 9813.1 9860.5 31871.4 32111.2 32703.3 33218.7 33540.3 42432.0 42975.4 43096.4 44090.3 44124.6 8427.0 8861.3 8883.3 8949.1 8956.2 10222.5 11490.8 15482.0 15545.5 15637.7 12737.2 13061.7 13167.2 13461.3 13473.8 2285.4 10172.9 12818.4 13483.9 13901.2 10425.5 13331.4 13797.9 13994.9 14418.6 7167.5 8721.5 8858.2 8865.2 8900.9 11169.6 13087.7 13104.5 13356.5 13608.5 09:16:10 INFO - 2015-11-20 09:16:10,378 DEBUG : BROWSER_OUTPUT: 09:16:10 INFO - 2015-11-20 09:16:10,378 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4922.47 Median:6176.90 stddev:2559.37 (41.4%) stddev-sans-first:2553.20 09:16:10 INFO - 2015-11-20 09:16:10,379 DEBUG : BROWSER_OUTPUT: Values: 1443.9 1646.7 1682.6 1727.5 1727.5 6128.9 6832.4 7004.6 7004.6 7013.4 6964.5 6997.5 7009.1 7073.6 7074.4 2084.5 2098.7 2102.8 2104.1 2105.9 2077.5 2084.9 2095.0 2120.8 2129.4 2064.5 2079.8 2088.1 2090.6 2093.4 2108.8 2120.7 2121.4 2124.9 2125.9 2077.1 2115.7 2117.8 2119.3 2123.7 5972.9 6169.5 7016.9 7049.8 7057.0 3978.1 4101.8 4106.1 4108.4 4110.6 2739.3 2754.4 2799.0 2800.0 2816.9 877.0 880.4 888.9 893.2 893.3 9592.9 9705.8 9707.8 9732.9 9739.0 4043.9 4060.0 4095.9 4102.4 4107.3 8427.5 8444.3 8447.9 8451.5 8452.0 4187.8 4219.2 4219.8 4223.9 4226.4 3833.6 3841.2 3843.8 3847.0 3852.9 3313.3 3324.3 3337.2 3352.9 3353.5 1057.3 1058.7 1060.2 1063.3 1066.7 878.2 880.2 892.2 892.4 1037.9 6568.4 6609.8 6617.7 6622.5 6634.8 424.5 433.3 437.9 437.9 439.5 4859.4 5245.8 5321.5 5325.8 5345.5 7498.0 8355.1 8428.2 8539.4 8540.1 8281.0 8367.4 8396.3 8404.2 8409.7 6518.3 6632.2 6685.5 6692.6 6704.0 6398.3 6426.7 6431.6 6450.1 6505.4 7229.6 7412.9 7424.0 7519.7 7549.6 7691.8 7802.2 7960.7 7972.8 7980.7 5754.7 5985.8 6047.5 6275.2 6298.4 6713.6 6746.9 6748.2 6750.2 6752.5 6387.2 6425.3 6465.4 6502.4 6530.0 6354.2 6371.2 6431.6 6441.8 6456.2 6232.1 6257.3 6270.5 6274.0 6279.4 5761.5 5789.5 5821.8 5828.1 5978.9 6110.3 6111.3 6129.6 6150.2 6184.3 09:16:10 INFO - 2015-11-20 09:16:10,379 DEBUG : BROWSER_OUTPUT: 09:16:10 INFO - 2015-11-20 09:16:10,379 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4749.30 Median:5411.04 stddev:1385.01 (25.6%) stddev-sans-first:1348.06 09:16:10 INFO - 2015-11-20 09:16:10,379 DEBUG : BROWSER_OUTPUT: Values: 301.3 310.6 312.3 312.7 314.5 5332.1 5445.4 5507.3 5514.8 5516.3 5402.1 5410.4 5410.6 5411.5 5415.0 4076.6 4147.3 4236.4 4243.5 4251.6 4146.3 4166.8 4272.7 4279.2 4293.5 4201.4 4231.7 4240.3 4246.3 4251.9 4021.5 4140.1 4233.0 4239.9 4250.0 3677.4 3746.2 3755.8 3766.5 3771.0 5199.3 5209.7 5210.8 5213.9 5215.0 4858.1 4878.7 4888.4 4890.0 4893.8 5602.2 5709.3 5716.1 5721.2 5733.1 4090.7 4091.9 4096.2 4096.6 4106.0 5989.5 6011.7 6016.8 6017.2 6017.2 4216.2 4217.1 4218.4 4220.4 4220.6 3994.4 4113.8 4280.5 4282.6 4286.9 4720.5 4742.8 4770.0 4773.8 4775.2 5731.9 5740.0 5746.2 5748.9 5750.1 1452.3 1474.4 1475.4 1475.5 1477.4 990.9 992.5 993.0 1006.1 1011.2 4982.6 5009.1 5010.8 5018.9 5020.3 5929.7 5930.8 5933.6 5935.8 5940.8 4991.0 4992.0 4997.9 5001.0 5002.8 3116.5 3176.9 3207.0 3209.8 3213.0 5586.1 5589.3 5593.0 5600.2 5603.2 6085.8 6093.3 6097.6 6101.5 6110.1 5476.0 5578.6 5587.4 5590.6 5601.6 5858.3 5923.5 5926.9 5939.6 5947.5 5801.2 5806.3 5807.9 5810.2 5813.1 5590.5 5598.5 5600.7 5604.4 5607.1 3998.9 4085.0 4103.0 4106.7 4111.4 5901.4 5904.2 5906.1 5922.2 5925.5 5690.3 5701.2 5708.9 5710.4 5711.5 5549.6 5693.9 5701.6 5702.4 5708.1 5567.7 5583.0 5585.6 5588.1 5591.2 5544.9 5697.0 5715.6 5744.6 5754.6 5433.9 5605.1 5606.5 5641.2 5646.1 09:16:10 INFO - 2015-11-20 09:16:10,379 DEBUG : BROWSER_OUTPUT: 09:16:10 INFO - 2015-11-20 09:16:10,379 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12418.26 Median:41375.48 stddev:14207.98 (34.3%) stddev-sans-first:14220.67 09:16:10 INFO - 2015-11-20 09:16:10,380 DEBUG : BROWSER_OUTPUT: Values: 717.3 729.1 757.1 797.4 813.2 11023.6 11231.6 11448.8 11784.0 11829.5 12069.5 12179.3 12185.0 12188.1 12198.3 623.6 631.9 793.9 798.2 812.5 811.1 811.5 816.4 816.6 817.0 849.2 850.2 851.4 857.7 858.0 647.1 658.8 842.7 867.5 870.5 613.7 619.8 620.8 621.0 621.2 11615.6 11755.8 11787.0 11803.6 11812.2 10436.5 10500.3 10882.9 11427.7 11876.9 8150.8 10021.4 10095.4 10293.5 10303.9 3200.7 3232.2 3238.4 3246.1 3297.1 40252.2 40356.2 40401.4 41395.6 42676.8 9358.2 9482.8 9505.4 9530.7 9588.3 16566.7 16910.8 16912.9 16940.6 16971.4 6205.0 6369.3 6489.3 6577.8 6587.5 3620.1 3665.1 3665.7 3674.4 3758.1 2689.8 2696.5 2702.8 2710.7 2724.9 491.6 494.1 497.3 500.5 507.2 573.5 583.5 593.5 638.4 638.4 7812.7 8437.5 8472.5 8534.3 8535.1 501.8 612.7 628.5 640.5 640.6 3582.0 3646.7 3698.5 3707.6 3741.3 52767.5 53421.5 53552.0 53795.5 53916.7 44493.8 44769.0 44971.3 45112.5 46519.8 40365.6 40446.4 40753.0 41050.8 41085.6 7237.5 7302.7 7337.4 7439.6 7576.3 30017.2 30274.7 30977.0 31136.2 31314.8 37596.8 40811.0 41057.6 41063.0 41355.4 10136.0 10275.9 10282.8 10283.9 10304.3 10994.2 11189.2 11239.1 11462.3 11556.0 9932.9 10176.1 10248.2 10278.9 10504.1 10580.9 10832.5 10962.8 11134.4 11238.0 10072.4 10390.2 10559.8 10616.3 10765.9 8980.2 9033.1 9070.0 9239.4 9475.6 8679.7 8813.6 8831.3 8999.0 9020.4 09:16:10 INFO - 2015-11-20 09:16:10,380 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:16:10 INFO - 2015-11-20 09:16:10,380 DEBUG : BROWSER_OUTPUT: 09:16:11 INFO - 2015-11-20 09:16:11,113 INFO : Browser exited with error code: 0 09:16:11 INFO - 2015-11-20 09:16:11,137 INFO : Completed test dromaeo_css (00:18:39) 09:16:11 INFO - 2015-11-20 09:16:11,137 INFO : Starting test kraken 09:16:11 INFO - 2015-11-20 09:16:11,137 DEBUG : operating with platform_type : linux_ 09:16:11 INFO - 2015-11-20 09:16:11,137 INFO : Initialising browser for kraken test... 09:16:11 INFO - 2015-11-20 09:16:11,143 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIp6SzF/profile http://localhost:33984/getInfo.html 09:16:15 INFO - 2015-11-20 09:16:15,530 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:16:15 INFO - 2015-11-20 09:16:15,530 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:16:15 INFO - 2015-11-20 09:16:15,530 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:16:15 INFO - 2015-11-20 09:16:15,530 DEBUG : BROWSER_OUTPUT: __metrics 09:16:15 INFO - 2015-11-20 09:16:15,631 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:16:17 INFO - 2015-11-20 09:16:17,312 INFO : Browser initialized. 09:16:17 INFO - 2015-11-20 09:16:17,312 INFO : Running cycle 1/1 for kraken test... 09:16:17 INFO - 2015-11-20 09:16:17,313 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIp6SzF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:16:29 INFO - 2015-11-20 09:16:29,268 DEBUG : BROWSER_OUTPUT: RSS: Main: 142077952 09:16:29 INFO - 2015-11-20 09:16:29,269 DEBUG : BROWSER_OUTPUT: 09:16:31 INFO - 2015-11-20 09:16:31,888 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33984/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33984/tests/kraken/driver.html?testName=audio-beat-detection) 09:16:32 INFO - 2015-11-20 09:16:32,475 DEBUG : BROWSER_OUTPUT: RSS: Main: 178753536 09:16:32 INFO - 2015-11-20 09:16:32,476 DEBUG : BROWSER_OUTPUT: 09:16:35 INFO - 2015-11-20 09:16:35,212 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33984/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33984/tests/kraken/driver.html?testName=audio-dft) 09:16:35 INFO - 2015-11-20 09:16:35,779 DEBUG : BROWSER_OUTPUT: RSS: Main: 168624128 09:16:35 INFO - 2015-11-20 09:16:35,779 DEBUG : BROWSER_OUTPUT: 09:16:38 INFO - 2015-11-20 09:16:38,823 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33984/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33984/tests/kraken/driver.html?testName=audio-fft) 09:16:39 INFO - 2015-11-20 09:16:39,383 DEBUG : BROWSER_OUTPUT: RSS: Main: 153096192 09:16:39 INFO - 2015-11-20 09:16:39,383 DEBUG : BROWSER_OUTPUT: 09:16:41 INFO - 2015-11-20 09:16:41,420 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33984/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33984/tests/kraken/driver.html?testName=audio-oscillator) 09:16:42 INFO - 2015-11-20 09:16:42,001 DEBUG : BROWSER_OUTPUT: RSS: Main: 155246592 09:16:42 INFO - 2015-11-20 09:16:42,001 DEBUG : BROWSER_OUTPUT: 09:16:44 INFO - 2015-11-20 09:16:44,198 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33984/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33984/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:16:44 INFO - 2015-11-20 09:16:44,767 DEBUG : BROWSER_OUTPUT: RSS: Main: 154853376 09:16:44 INFO - 2015-11-20 09:16:44,767 DEBUG : BROWSER_OUTPUT: 09:16:47 INFO - 2015-11-20 09:16:47,725 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33984/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33984/tests/kraken/driver.html?testName=imaging-darkroom) 09:16:48 INFO - 2015-11-20 09:16:48,306 DEBUG : BROWSER_OUTPUT: RSS: Main: 156119040 09:16:48 INFO - 2015-11-20 09:16:48,306 DEBUG : BROWSER_OUTPUT: 09:16:51 INFO - 2015-11-20 09:16:51,773 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33984/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33984/tests/kraken/driver.html?testName=imaging-desaturate) 09:16:52 INFO - 2015-11-20 09:16:52,354 DEBUG : BROWSER_OUTPUT: RSS: Main: 157413376 09:16:52 INFO - 2015-11-20 09:16:52,355 DEBUG : BROWSER_OUTPUT: 09:16:55 INFO - 2015-11-20 09:16:55,197 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33984/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33984/tests/kraken/driver.html?testName=json-parse-financial) 09:16:55 INFO - 2015-11-20 09:16:55,778 DEBUG : BROWSER_OUTPUT: RSS: Main: 158453760 09:16:55 INFO - 2015-11-20 09:16:55,779 DEBUG : BROWSER_OUTPUT: 09:16:57 INFO - 2015-11-20 09:16:57,528 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33984/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33984/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:16:58 INFO - 2015-11-20 09:16:58,093 DEBUG : BROWSER_OUTPUT: RSS: Main: 163983360 09:16:58 INFO - 2015-11-20 09:16:58,093 DEBUG : BROWSER_OUTPUT: 09:16:59 INFO - 2015-11-20 09:16:59,983 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33984/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33984/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:17:00 INFO - 2015-11-20 09:17:00,585 DEBUG : BROWSER_OUTPUT: RSS: Main: 162930688 09:17:00 INFO - 2015-11-20 09:17:00,585 DEBUG : BROWSER_OUTPUT: 09:17:02 INFO - 2015-11-20 09:17:02,742 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33984/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33984/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:17:03 INFO - 2015-11-20 09:17:03,328 DEBUG : BROWSER_OUTPUT: RSS: Main: 173232128 09:17:03 INFO - 2015-11-20 09:17:03,329 DEBUG : BROWSER_OUTPUT: 09:17:05 INFO - 2015-11-20 09:17:05,884 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33984/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33984/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:17:06 INFO - 2015-11-20 09:17:06,466 DEBUG : BROWSER_OUTPUT: RSS: Main: 181002240 09:17:06 INFO - 2015-11-20 09:17:06,466 DEBUG : BROWSER_OUTPUT: 09:17:09 INFO - 2015-11-20 09:17:09,020 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33984/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33984/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:17:09 INFO - 2015-11-20 09:17:09,589 DEBUG : BROWSER_OUTPUT: RSS: Main: 177401856 09:17:09 INFO - 2015-11-20 09:17:09,590 DEBUG : BROWSER_OUTPUT: 09:17:11 INFO - 2015-11-20 09:17:11,330 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33984/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33984/tests/kraken/driver.html?testName=ai-astar) 09:17:11 INFO - 2015-11-20 09:17:11,588 DEBUG : BROWSER_OUTPUT: RSS: Main: 236212224 09:17:11 INFO - 2015-11-20 09:17:11,588 DEBUG : BROWSER_OUTPUT: 09:17:11 INFO - 2015-11-20 09:17:11,588 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:17:11 INFO - 2015-11-20 09:17:11,588 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:17:11 INFO - 2015-11-20 09:17:11,588 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:17:11 INFO - 2015-11-20 09:17:11,588 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:17:11 INFO - 2015-11-20 09:17:11,589 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;113;105;110;111;112;99;111;116;111 09:17:11 INFO - 2015-11-20 09:17:11,589 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;130;158;169;131;155;162;136;163;131 09:17:11 INFO - 2015-11-20 09:17:11,589 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;161;162;161;161;161;162;162;162;161 09:17:11 INFO - 2015-11-20 09:17:11,589 DEBUG : BROWSER_OUTPUT: |3;audio-fft;74;75;84;92;72;73;72;94;93;72 09:17:11 INFO - 2015-11-20 09:17:11,589 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;92;131;91;92;92;124;91;91;130 09:17:11 INFO - 2015-11-20 09:17:11,589 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;109;110;109;109;109;110;109 09:17:11 INFO - 2015-11-20 09:17:11,589 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;146;147;147;146;147;146;147;146;147 09:17:11 INFO - 2015-11-20 09:17:11,589 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;95;95;95;95;95;95;95;95 09:17:11 INFO - 2015-11-20 09:17:11,590 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;69;68;69;69;69;70;69;78;67;67 09:17:11 INFO - 2015-11-20 09:17:11,590 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;68;68;68;68;69;68;68;68;74 09:17:11 INFO - 2015-11-20 09:17:11,590 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;85;84;86;86;86;84;82;94;85 09:17:11 INFO - 2015-11-20 09:17:11,590 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;127;125;118;127;118;122;121;128;121;129 09:17:11 INFO - 2015-11-20 09:17:11,590 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;145;134;145;145;149;134;147;146;134;134 09:17:11 INFO - 2015-11-20 09:17:11,590 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;70;68;69;69;68;73;69;68;69 09:17:11 INFO - 2015-11-20 09:17:11,590 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:17:11 INFO - 2015-11-20 09:17:11,590 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:17:11 INFO - 2015-11-20 09:17:11,590 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,977 09:17:11 INFO - 2015-11-20 09:17:11,590 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:17:11 INFO - 2015-11-20 09:17:11,591 DEBUG : BROWSER_OUTPUT: __startTimestamp1448039831583__endTimestamp 09:17:11 INFO - 2015-11-20 09:17:11,591 DEBUG : BROWSER_OUTPUT: 09:17:11 INFO - 2015-11-20 09:17:11,591 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:17:11 INFO - 2015-11-20 09:17:11,591 DEBUG : BROWSER_OUTPUT: Number of tests: 14 09:17:11 INFO - 2015-11-20 09:17:11,591 DEBUG : BROWSER_OUTPUT: 09:17:11 INFO - 2015-11-20 09:17:11,591 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.90 Median:111.50 stddev:4.70 (4.2%) stddev-sans-first:4.97 09:17:11 INFO - 2015-11-20 09:17:11,591 DEBUG : BROWSER_OUTPUT: Values: 111.0 113.0 105.0 110.0 111.0 112.0 99.0 111.0 116.0 111.0 09:17:11 INFO - 2015-11-20 09:17:11,591 DEBUG : BROWSER_OUTPUT: 09:17:11 INFO - 2015-11-20 09:17:11,591 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.80 Median:156.50 stddev:15.19 (9.7%) stddev-sans-first:16.03 09:17:11 INFO - 2015-11-20 09:17:11,591 DEBUG : BROWSER_OUTPUT: Values: 153.0 130.0 158.0 169.0 131.0 155.0 162.0 136.0 163.0 131.0 09:17:11 INFO - 2015-11-20 09:17:11,592 DEBUG : BROWSER_OUTPUT: 09:17:11 INFO - 2015-11-20 09:17:11,592 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:0.53 (0.3%) stddev-sans-first:0.53 09:17:11 INFO - 2015-11-20 09:17:11,592 DEBUG : BROWSER_OUTPUT: Values: 162.0 161.0 162.0 161.0 161.0 161.0 162.0 162.0 162.0 161.0 09:17:11 INFO - 2015-11-20 09:17:11,592 DEBUG : BROWSER_OUTPUT: 09:17:11 INFO - 2015-11-20 09:17:11,592 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.10 Median:79.50 stddev:9.59 (12.1%) stddev-sans-first:9.91 09:17:11 INFO - 2015-11-20 09:17:11,593 DEBUG : BROWSER_OUTPUT: Values: 74.0 75.0 84.0 92.0 72.0 73.0 72.0 94.0 93.0 72.0 09:17:11 INFO - 2015-11-20 09:17:11,593 DEBUG : BROWSER_OUTPUT: 09:17:11 INFO - 2015-11-20 09:17:11,593 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.60 Median:91.50 stddev:17.85 (19.5%) stddev-sans-first:18.52 09:17:11 INFO - 2015-11-20 09:17:11,593 DEBUG : BROWSER_OUTPUT: Values: 92.0 92.0 131.0 91.0 92.0 92.0 124.0 91.0 91.0 130.0 09:17:11 INFO - 2015-11-20 09:17:11,593 DEBUG : BROWSER_OUTPUT: 09:17:11 INFO - 2015-11-20 09:17:11,593 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 09:17:11 INFO - 2015-11-20 09:17:11,593 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 109.0 110.0 109.0 109.0 109.0 110.0 109.0 09:17:11 INFO - 2015-11-20 09:17:11,593 DEBUG : BROWSER_OUTPUT: 09:17:11 INFO - 2015-11-20 09:17:11,593 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 09:17:11 INFO - 2015-11-20 09:17:11,593 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 147.0 147.0 146.0 147.0 146.0 147.0 146.0 147.0 09:17:11 INFO - 2015-11-20 09:17:11,594 DEBUG : BROWSER_OUTPUT: 09:17:11 INFO - 2015-11-20 09:17:11,594 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 09:17:11 INFO - 2015-11-20 09:17:11,594 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 09:17:11 INFO - 2015-11-20 09:17:11,594 DEBUG : BROWSER_OUTPUT: 09:17:11 INFO - 2015-11-20 09:17:11,594 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:69.50 Median:69.00 stddev:3.14 (4.5%) stddev-sans-first:3.32 09:17:11 INFO - 2015-11-20 09:17:11,594 DEBUG : BROWSER_OUTPUT: Values: 69.0 68.0 69.0 69.0 69.0 70.0 69.0 78.0 67.0 67.0 09:17:11 INFO - 2015-11-20 09:17:11,594 DEBUG : BROWSER_OUTPUT: 09:17:11 INFO - 2015-11-20 09:17:11,594 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.80 Median:68.00 stddev:1.87 (2.8%) stddev-sans-first:1.99 09:17:11 INFO - 2015-11-20 09:17:11,594 DEBUG : BROWSER_OUTPUT: Values: 69.0 68.0 68.0 68.0 68.0 69.0 68.0 68.0 68.0 74.0 09:17:11 INFO - 2015-11-20 09:17:11,594 DEBUG : BROWSER_OUTPUT: 09:17:11 INFO - 2015-11-20 09:17:11,594 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:85.50 stddev:3.20 (3.7%) stddev-sans-first:3.35 09:17:11 INFO - 2015-11-20 09:17:11,595 DEBUG : BROWSER_OUTPUT: Values: 84.0 85.0 84.0 86.0 86.0 86.0 84.0 82.0 94.0 85.0 09:17:11 INFO - 2015-11-20 09:17:11,595 DEBUG : BROWSER_OUTPUT: 09:17:11 INFO - 2015-11-20 09:17:11,595 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.60 Median:126.00 stddev:4.12 (3.3%) stddev-sans-first:4.18 09:17:11 INFO - 2015-11-20 09:17:11,595 DEBUG : BROWSER_OUTPUT: Values: 127.0 125.0 118.0 127.0 118.0 122.0 121.0 128.0 121.0 129.0 09:17:11 INFO - 2015-11-20 09:17:11,595 DEBUG : BROWSER_OUTPUT: 09:17:11 INFO - 2015-11-20 09:17:11,595 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.30 Median:145.00 stddev:6.40 (4.4%) stddev-sans-first:6.64 09:17:11 INFO - 2015-11-20 09:17:11,595 DEBUG : BROWSER_OUTPUT: Values: 145.0 134.0 145.0 145.0 149.0 134.0 147.0 146.0 134.0 134.0 09:17:11 INFO - 2015-11-20 09:17:11,595 DEBUG : BROWSER_OUTPUT: 09:17:11 INFO - 2015-11-20 09:17:11,595 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:69.00 stddev:1.48 (2.1%) stddev-sans-first:1.56 09:17:11 INFO - 2015-11-20 09:17:11,595 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 68.0 69.0 69.0 68.0 73.0 69.0 68.0 69.0 09:17:11 INFO - 2015-11-20 09:17:11,595 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:17:11 INFO - 2015-11-20 09:17:11,596 DEBUG : BROWSER_OUTPUT: 09:17:12 INFO - 2015-11-20 09:17:12,537 INFO : Browser exited with error code: 0 09:17:12 INFO - 2015-11-20 09:17:12,587 INFO : Completed test kraken (00:01:01) 09:17:12 INFO - 2015-11-20 09:17:12,587 INFO : Starting test v8_7 09:17:12 INFO - 2015-11-20 09:17:12,587 DEBUG : operating with platform_type : linux_ 09:17:12 INFO - 2015-11-20 09:17:12,587 INFO : Initialising browser for v8_7 test... 09:17:12 INFO - 2015-11-20 09:17:12,593 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAyzBjQ/profile http://localhost:33984/getInfo.html 09:17:16 INFO - 2015-11-20 09:17:16,953 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:17:16 INFO - 2015-11-20 09:17:16,953 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:17:16 INFO - 2015-11-20 09:17:16,953 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:17:16 INFO - 2015-11-20 09:17:16,953 DEBUG : BROWSER_OUTPUT: __metrics 09:17:17 INFO - 2015-11-20 09:17:17,150 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:17:18 INFO - 2015-11-20 09:17:18,564 INFO : Browser initialized. 09:17:18 INFO - 2015-11-20 09:17:18,564 INFO : Running cycle 1/1 for v8_7 test... 09:17:18 INFO - 2015-11-20 09:17:18,564 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAyzBjQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:17:30 INFO - 2015-11-20 09:17:30,496 DEBUG : BROWSER_OUTPUT: RSS: Main: 142127104 09:17:30 INFO - 2015-11-20 09:17:30,497 DEBUG : BROWSER_OUTPUT: 09:17:51 INFO - 2015-11-20 09:17:51,868 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33984/tests/v8_7/run.html (next: http://localhost:33984/tests/v8_7/run.html) 09:17:52 INFO - 2015-11-20 09:17:52,118 DEBUG : BROWSER_OUTPUT: RSS: Main: 442630144 09:17:52 INFO - 2015-11-20 09:17:52,119 DEBUG : BROWSER_OUTPUT: 09:17:52 INFO - 2015-11-20 09:17:52,120 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:17:52 INFO - 2015-11-20 09:17:52,120 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:17:52 INFO - 2015-11-20 09:17:52,121 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:17:52 INFO - 2015-11-20 09:17:52,121 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:17:52 INFO - 2015-11-20 09:17:52,121 DEBUG : BROWSER_OUTPUT: |0;Richards;163.47882949158085 09:17:52 INFO - 2015-11-20 09:17:52,121 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.16803670426305 09:17:52 INFO - 2015-11-20 09:17:52,122 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.4076557697681 09:17:52 INFO - 2015-11-20 09:17:52,122 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5050.50505050505 09:17:52 INFO - 2015-11-20 09:17:52,122 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1990.0596421471173 09:17:52 INFO - 2015-11-20 09:17:52,122 DEBUG : BROWSER_OUTPUT: |5;Earley;793.0214115781126 09:17:52 INFO - 2015-11-20 09:17:52,123 DEBUG : BROWSER_OUTPUT: |6;Boyer;12432.098765432098 09:17:52 INFO - 2015-11-20 09:17:52,123 DEBUG : BROWSER_OUTPUT: |7;RegExp;27027.027027027027 09:17:52 INFO - 2015-11-20 09:17:52,123 DEBUG : BROWSER_OUTPUT: |8;Splay;603.9544637507489 09:17:52 INFO - 2015-11-20 09:17:52,123 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 09:17:52 INFO - 2015-11-20 09:17:52,123 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:17:52 INFO - 2015-11-20 09:17:52,124 DEBUG : BROWSER_OUTPUT: __startTimestamp1448039872119__endTimestamp 09:17:52 INFO - 2015-11-20 09:17:52,124 DEBUG : BROWSER_OUTPUT: 09:17:52 INFO - 2015-11-20 09:17:52,124 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:17:52 INFO - 2015-11-20 09:17:52,125 DEBUG : BROWSER_OUTPUT: Number of tests: 10 09:17:52 INFO - 2015-11-20 09:17:52,125 DEBUG : BROWSER_OUTPUT: 09:17:52 INFO - 2015-11-20 09:17:52,125 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.48 Median:163.48 stddev:0.00 (0.0%) 09:17:52 INFO - 2015-11-20 09:17:52,125 DEBUG : BROWSER_OUTPUT: Values: 163.5 09:17:52 INFO - 2015-11-20 09:17:52,126 DEBUG : BROWSER_OUTPUT: 09:17:52 INFO - 2015-11-20 09:17:52,127 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.17 Median:191.17 stddev:0.00 (0.0%) 09:17:52 INFO - 2015-11-20 09:17:52,127 DEBUG : BROWSER_OUTPUT: Values: 191.2 09:17:52 INFO - 2015-11-20 09:17:52,127 DEBUG : BROWSER_OUTPUT: 09:17:52 INFO - 2015-11-20 09:17:52,128 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.41 Median:279.41 stddev:0.00 (0.0%) 09:17:52 INFO - 2015-11-20 09:17:52,128 DEBUG : BROWSER_OUTPUT: Values: 279.4 09:17:52 INFO - 2015-11-20 09:17:52,128 DEBUG : BROWSER_OUTPUT: 09:17:52 INFO - 2015-11-20 09:17:52,128 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5050.51 Median:5050.51 stddev:0.00 (0.0%) 09:17:52 INFO - 2015-11-20 09:17:52,128 DEBUG : BROWSER_OUTPUT: Values: 5050.5 09:17:52 INFO - 2015-11-20 09:17:52,129 DEBUG : BROWSER_OUTPUT: 09:17:52 INFO - 2015-11-20 09:17:52,129 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1990.06 Median:1990.06 stddev:0.00 (0.0%) 09:17:52 INFO - 2015-11-20 09:17:52,129 DEBUG : BROWSER_OUTPUT: Values: 1990.1 09:17:52 INFO - 2015-11-20 09:17:52,129 DEBUG : BROWSER_OUTPUT: 09:17:52 INFO - 2015-11-20 09:17:52,130 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:793.02 Median:793.02 stddev:0.00 (0.0%) 09:17:52 INFO - 2015-11-20 09:17:52,130 DEBUG : BROWSER_OUTPUT: Values: 793.0 09:17:52 INFO - 2015-11-20 09:17:52,130 DEBUG : BROWSER_OUTPUT: 09:17:52 INFO - 2015-11-20 09:17:52,130 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12432.10 Median:12432.10 stddev:0.00 (0.0%) 09:17:52 INFO - 2015-11-20 09:17:52,130 DEBUG : BROWSER_OUTPUT: Values: 12432.1 09:17:52 INFO - 2015-11-20 09:17:52,131 DEBUG : BROWSER_OUTPUT: 09:17:52 INFO - 2015-11-20 09:17:52,131 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27027.03 Median:27027.03 stddev:0.00 (0.0%) 09:17:52 INFO - 2015-11-20 09:17:52,131 DEBUG : BROWSER_OUTPUT: Values: 27027.0 09:17:52 INFO - 2015-11-20 09:17:52,131 DEBUG : BROWSER_OUTPUT: 09:17:52 INFO - 2015-11-20 09:17:52,132 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:603.95 Median:603.95 stddev:0.00 (0.0%) 09:17:52 INFO - 2015-11-20 09:17:52,132 DEBUG : BROWSER_OUTPUT: Values: 604.0 09:17:52 INFO - 2015-11-20 09:17:52,132 DEBUG : BROWSER_OUTPUT: 09:17:52 INFO - 2015-11-20 09:17:52,132 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 09:17:52 INFO - 2015-11-20 09:17:52,132 DEBUG : BROWSER_OUTPUT: Values: 4835.7 09:17:52 INFO - 2015-11-20 09:17:52,133 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:17:52 INFO - 2015-11-20 09:17:52,133 DEBUG : BROWSER_OUTPUT: 09:17:53 INFO - 2015-11-20 09:17:53,133 INFO : Browser exited with error code: 0 09:17:53 INFO - 2015-11-20 09:17:53,145 INFO : Completed test v8_7 (00:00:40) 09:17:53 INFO - 2015-11-20 09:17:53,168 INFO : Completed test suite (00:20:21) 09:17:53 INFO - 2015-11-20 09:17:53,168 DEBUG : Working with test: dromaeo_css 09:17:53 INFO - 2015-11-20 09:17:53,168 DEBUG : Generating results file: dromaeo_css 09:17:53 INFO - 2015-11-20 09:17:53,169 DEBUG : Working with test: kraken 09:17:53 INFO - 2015-11-20 09:17:53,169 DEBUG : Generating results file: kraken 09:17:53 INFO - 2015-11-20 09:17:53,169 INFO : javascript benchmark 09:17:53 INFO - 2015-11-20 09:17:53,170 DEBUG : Working with test: v8_7 09:17:53 INFO - 2015-11-20 09:17:53,170 DEBUG : Generating results file: v8_7 09:17:53 INFO - 2015-11-20 09:17:53,170 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:17:53 INFO - 2015-11-20 09:17:53,224 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 09:17:53 INFO - 2015-11-20 09:17:53,224 DEBUG : process_Request line: dromaeo_css 6313.68 graph.html#tests=[[72,132,35]] 09:17:53 INFO - 2015-11-20 09:17:53,224 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:17:53 INFO - 2015-11-20 09:17:53,255 DEBUG : process_Request line: kraken 1511.80 graph.html#tests=[[232,132,35]] 09:17:53 INFO - 2015-11-20 09:17:53,255 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:17:53 INFO - 2015-11-20 09:17:53,289 DEBUG : process_Request line: v8_7 19769.18 graph.html#tests=[[230,132,35]] 09:17:53 INFO - 2015-11-20 09:17:53,290 INFO : javascript benchmark 09:17:53 INFO - 2015-11-20 09:17:53,294 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2681.772049375803, 2785.7353551412607, 2790.5814127880826, 2799.6640403151614, 2802.1033269353807, 4536.6370690344775, 4653.0228651983125, 4800.231962885939, 4829.154897892868, 4845.055214233226, 4699.271612899997, 4713.387259656249, 4806.20697584899, 4817.132916075105, 4835.661503694742, 4407.382966384709, 4467.0, 4474.463064432272, 4489.214387482178, 4490.910181796362, 4248.490181178263, 4533.607375303455, 4583.175028494869, 4640.373549570799, 4644.790984405693, 4326.935095973563, 4389.692721509479, 4422.04925940921, 4424.867253982354, 4437.0682156747125, 4469.508354081048, 4474.373587697725, 4474.731516109011, 4479.552044795527, 4512.593866552026, 4171.6036976487185, 4452.287633978548, 4455.242608756519, 4471.955280447187, 4496.4829044659955, 4615.515370886043, 4626.861194164147, 4649.279361698942, 4713.858584242478, 4766.833160839354, 5128.769205385729, 5131.281620573122, 5133.845984620468, 5159.0, 5172.431032586413, 4863.927041094386, 5157.71632560209, 5159.380874295071, 5168.22476628505, 5192.662476938987, 4760.857174284777, 4770.165221086296, 4785.784639691187, 4795.688280261772, 4861.611071114302, 5317.14925611908, 5393.8112166074, 5396.4333744957, 5400.351957765093, 5441.619086663895, 4867.172580661296, 5156.690598564098, 5175.094358487249, 5180.637355385163, 5223.947760522422, 4996.525330093636, 4996.825111121166, 5006.549410553068, 5038.193888977819, 5145.974270128625, 5025.673331233531, 5106.846794596168, 5146.202338637442, 5147.459516750687, 5154.587632989352, 5128.769205385766, 5131.281620573122, 5131.846044618667, 5136.152534831711, 5136.383633963948, 4139.627433530996, 4244.660427165819, 4244.893877653083, 4279.079997800488, 4353.564643535685, 3797.5632802227547, 3828.8468461261236, 3833.8466461341236, 3860.4402361657963, 3888.863889763845, 4397.428334316518, 4434.467863856358, 4435.512093669694, 4446.644268458515, 4474.038081812426, 4882.462929077798, 4982.402111746541, 4992.975035124874, 5177.663451875616, 5256.08018596744, 4369.9126017479475, 4424.6902716810155, 4442.666799990014, 4484.708493947883, 4490.640748740093, 4652.930206046912, 4657.0685862826895, 4674.929876051862, 4687.226607609706, 4688.648351373592, 4696.38946936896, 4837.516248375135, 4838.709677419366, 4906.607471402351, 4932.90134197314, 5039.496050394931, 5186.222066689876, 5281.075811732854, 5333.173358129496, 5338.893222135458, 4909.754512274443, 4931.753412329297, 4933.210686290176, 4935.703857768545, 4974.0, 5099.69401835891, 5105.5149760772665, 5112.539871411591, 5128.615353848401, 5142.1772516397195, 4886.65793394459, 5023.1711767557945, 5066.6200034998255, 5067.543921047123, 5076.923846142385, 5077.466865979019, 5111.744412779271, 5113.347868940481, 5113.616478764033, 5116.692998420107, 5077.0, 5083.110455670169, 5089.185730283137, 5090.592752579859, 5110.974445127899, 4689.507601701772, 4808.110499557453, 4810.542998415145, 4854.1747902857305, 4951.257311403318, 5096.877637973813, 5150.587952963679, 5153.072446959583, 5155.845324640267, 5203.401608815035, 4989.525995030466, 5006.574441172541, 5017.781701556575, 5027.59779217669, 5071.568916642127], "unit": "ms", "name": "dojo.html", "value": 4731.485068339205}, {"lowerIsBetter": false, "replicates": [557.6431084106173, 559.8180591307826, 563.0372063770955, 565.3865555871879, 578.965262084275, 27707.168784936435, 28181.29546761332, 28216.294592635193, 28263.57604635932, 28298.292542686442, 30144.849275753644, 30656.540151897683, 37589.62410375896, 39021.41467877984, 39038.804805976004, 7906.130325664172, 8050.557219352933, 8055.718049868256, 8056.0, 8069.072056713465, 7166.713331466735, 7880.211978802103, 7966.6415011324625, 8003.51978881266, 8012.238837310446, 7115.2884711528695, 10188.847167292497, 10455.84316235257, 10462.110720588758, 10468.371897686126, 9857.95071024644, 9910.058544438267, 9946.20430365569, 9955.701328960144, 9979.251556133318, 7174.461915356369, 7355.668994895243, 9627.56675949584, 9742.07450292221, 10134.847977280348, 38043.619563804285, 38541.80729096365, 38575.42136867949, 38639.0, 38706.225875482334, 2886.5092934201234, 2905.375344300964, 2970.55441683747, 3204.7756657034015, 3423.7432192585657, 29065.564016539767, 29239.2690182745, 29241.85379073091, 29606.555901661275, 30139.397212055635, 3511.3855075361967, 3529.082438565991, 3577.123604716835, 3590.0, 3623.800690961996, 328687.0, 331042.0, 331435.0, 332539.99999999756, 333185.0, 56835.71582142063, 57717.71141144267, 57817.132743008886, 57832.3975421107, 57858.710706446196, 61665.0, 62005.37994619996, 62064.0, 62093.379066209665, 62126.0, 13038.608841734764, 13239.338033098307, 13252.403641836141, 13319.134256273312, 13431.932840335736, 10031.749206269902, 10065.144462720751, 10082.04220599042, 10084.546195421224, 10092.646757363456, 19442.611147777247, 19876.50308742264, 19916.402507924784, 19924.800751992585, 19958.30145944885, 7807.6486558105025, 7982.321502672222, 7985.361171106298, 8026.558539280279, 8041.3164880984605, 839.7312859884778, 856.6188046319328, 863.1842908451453, 885.9955700221586, 982.3025651787168, 26723.19830405091, 26794.732052679225, 27099.729002710115, 27169.184924452296, 27205.0, 874.1171416868881, 944.4899754132829, 947.2138125355938, 996.3722854601555, 1022.2844009193594, 12977.35113244334, 15757.527274181793, 16397.91801041011, 16463.588410289598, 16622.168891555375, 325100.0, 330577.0, 331633.0, 332620.0, 333297.0, 47130.0, 48246.5175348249, 54359.45640543544, 55712.72143639337, 55761.721191394594, 1215.6899990502366, 1219.71336735867, 1221.4625564751482, 1245.2341809786915, 1260.8676089010705, 24092.87953560221, 26224.475510490065, 27312.863435682695, 29238.561421579117, 30448.238794030327, 44393.0, 45244.77377613091, 45305.546944530135, 45345.54654453413, 45396.31905521486, 247225.0, 250406.0, 250676.0, 251093.0, 251270.0, 40199.3970090443, 40392.79803600963, 40429.59570404376, 40859.59140408558, 40961.59038409697, 41280.0, 42344.0, 42957.57042429536, 43345.133097338505, 43377.0, 34454.621815128114, 34836.129096772784, 35312.82343588266, 38220.61779382282, 39982.2003559933, 34342.0, 38066.80966595149, 39801.0, 40207.79896100618, 40530.79734601308, 34872.30255394827, 34910.47634285437, 34911.0, 35319.82340088283, 35473.82263088668, 30462.695373046874, 31582.842085789423, 31873.36253274875, 32043.198920026254, 32082.51876221812, 24259.878700606383, 24451.51096978015, 24625.87687061553, 24936.625950610392, 24987.125450609143], "unit": "ms", "name": "ext.html", "value": 17975.771361871582}, {"lowerIsBetter": false, "replicates": [322.74241679452234, 327.8426355349432, 338.52268301694613, 342.209496064092, 343.3407856914723, 12439.875601243984, 12813.487460501568, 15468.535943921686, 16056.83943160568, 16832.410865619706, 13731.0, 13832.0, 14140.92929535351, 14149.57551273461, 14160.0, 4889.095517329288, 4920.040592084554, 4958.206686930092, 4988.501149885019, 5059.671121377117, 3608.332458495174, 3766.6986641068647, 5699.2590963174935, 5935.851603709899, 5940.910886336708, 5783.681897495636, 5866.735996880129, 5869.148973398855, 5871.089981052944, 5894.115882617599, 5799.855003624901, 5869.530437564985, 5879.206307148523, 5879.618289701916, 5886.440788125121, 5051.06555287273, 5120.718360490171, 5145.948540514584, 5146.562542183919, 5147.536721695028, 19247.23011079555, 19397.903010485, 19581.314653987185, 19682.0, 19731.309404170785, 1809.3215044358365, 1847.29802674984, 1873.363056560776, 1952.0727654364205, 1994.58113796103, 12418.130730848845, 12540.0, 12713.809292860615, 12812.16720913147, 13093.934530327382, 1757.2531674038482, 1770.663573920951, 1779.146009915248, 1796.793368762596, 1826.4429349048535, 52824.47175528234, 53690.19464707994, 54549.454505454836, 55173.0, 55635.44364556343, 9209.907900920905, 9341.813163736688, 9506.524673766422, 9585.760355991017, 9608.2793790466, 12001.699957501132, 12075.516979320904, 12142.0, 12149.271043737228, 12155.696107597381, 6809.659517024129, 6834.692438840264, 6951.826204344932, 7002.509824312351, 7023.438124949992, 6348.301686814447, 6393.424591786761, 6416.967915160488, 6432.35676432353, 6434.9678251609375, 5652.858678532987, 5726.885462290731, 5728.140778883201, 5748.7125643717645, 5861.73972595894, 1475.2623688155923, 1631.7633943078188, 1642.1789105447276, 1689.5691598642513, 1692.678391105686, 359.8632519642519, 364.22056798451337, 403.9454673619024, 819.1521774963004, 851.4635779458902, 9345.682342714988, 10026.0, 10062.74843128913, 10069.69790906274, 10278.434686092187, 378.3586820339553, 400.96591789698203, 408.573041171976, 414.4094665102217, 429.18026569253203, 4603.562661547147, 5361.892762144736, 5420.13277875538, 5470.17947307907, 5470.753816078286, 451582.0, 452188.0, 459674.0, 461094.0, 463320.0, 69119.0, 71499.64250178715, 71591.0, 72185.63907180431, 72308.0, 458.8027148326185, 461.19981831522284, 461.98614041578804, 463.0715415591717, 463.9466461356987, 9436.622535098519, 9595.0, 9668.274879384215, 9813.11681948628, 9860.506974651382, 31871.36257274888, 32111.197220069684, 32703.34593308168, 33218.66781332252, 33540.329193415506, 42432.0, 42975.355369670106, 43096.35355469733, 44090.338644920994, 44124.55875441333, 8426.957865210634, 8861.33539984491, 8883.333749968908, 8949.105089490999, 8956.193942545202, 10222.539985700512, 11490.82763758561, 15482.0, 15545.533633990999, 15637.687246254784, 12737.172083814523, 13061.673458163621, 13167.209967401986, 13461.326933653474, 13473.797893031417, 2285.3943704918543, 10172.949135254275, 12818.423170957516, 13483.896699571322, 13901.16593004423, 10425.53085111187, 13331.400086996302, 13797.931010344884, 13994.930025349808, 14418.639534011314, 7167.462440316893, 8721.520316382406, 8858.158474945129, 8865.24645405122, 8900.910990890266, 11169.553217871195, 13087.738245235232, 13104.475820967054, 13356.465741370237, 13608.455661773418], "unit": "ms", "name": "jquery.html", "value": 7543.462459145694}, {"lowerIsBetter": false, "replicates": [1443.9494617688383, 1646.6953613581486, 1682.6045879218382, 1727.4558514068067, 1727.4817554733577, 6128.877422451548, 6832.419244364229, 7004.57972521649, 7004.64976751163, 7013.43892488601, 6964.547304425221, 6997.545159564625, 7009.053777740003, 7073.610951397671, 7074.434045276378, 2084.541400891805, 2098.7481502219757, 2102.8317734581196, 2104.084723145437, 2105.8631188972668, 2077.45986043629, 2084.895755212241, 2095.025812996956, 2120.7773183815707, 2129.3931229599566, 2064.5354795171042, 2079.8336133109315, 2088.1229883448987, 2090.644590419625, 2093.3510611710344, 2108.7891210878943, 2120.692499587551, 2121.374194612585, 2124.9256276030264, 2125.9468513287216, 2077.1379877350882, 2115.6509175985943, 2117.76704562498, 2119.3218170185546, 2123.6814477828293, 5972.880542389172, 6169.537284703665, 7016.929830701679, 7049.7885063448175, 7057.047298614672, 3978.0651546886456, 4101.815418306153, 4106.07613287011, 4108.424820525129, 4110.609492098246, 2739.2877851758685, 2754.4353407551403, 2799.0, 2799.958000629992, 2816.915492535207, 877.0440220159992, 880.4409200157882, 888.8888888888889, 893.1782759860944, 893.3389291923929, 9592.856107158399, 9705.805883882284, 9707.757306067335, 9732.854007189828, 9738.9513052435, 4043.8786836394956, 4060.045889216032, 4095.9350568852315, 4102.425660407545, 4107.260693075275, 8427.452215605967, 8444.324454043663, 8447.873281900776, 8451.45065570736, 8452.02801677815, 4187.832486700498, 4219.198352313051, 4219.767912764827, 4223.915521689549, 4226.408302837605, 3833.559140698855, 3841.1741475582326, 3843.7885916274313, 3846.9805501542114, 3852.9422058669143, 3313.3042061167425, 3324.3185147044796, 3337.1657085728566, 3352.8826491072696, 3353.480210567366, 1057.2599180573475, 1058.6823952814125, 1060.2472244706191, 1063.2769716592636, 1066.6693325069252, 878.1657425445725, 880.1946219209352, 892.2237653241591, 892.3931726426092, 1037.9273450858518, 6568.441682457044, 6609.768658096944, 6617.702203400859, 6622.4702023838945, 6634.767783127664, 424.4651738809123, 433.29589417197053, 437.8992831648675, 437.94525684289465, 439.5077513185253, 4859.416869975555, 5245.816396426107, 5321.521063104262, 5325.840224793263, 5345.4654534546235, 7498.0, 8355.122712115262, 8428.157184281523, 8539.359548033797, 8540.060593334729, 8281.0, 8367.372447066495, 8396.286315663116, 8404.24361807428, 8409.663613455516, 6518.250401203827, 6632.237292711304, 6685.465162786965, 6692.631905245258, 6704.0, 6398.296187419287, 6426.710798014195, 6431.5819471734185, 6450.129232553733, 6505.447037001719, 7229.566226026455, 7412.851742965218, 7423.962880185564, 7519.661615227437, 7549.584772837547, 7691.769246922601, 7802.180771018961, 7960.681572737026, 7972.800679983046, 7980.720674776355, 5754.6547207167705, 5985.790497332572, 6047.485963693135, 6275.246970363585, 6298.370162983665, 6713.63075030878, 6746.8650626988165, 6748.223954245128, 6750.2237242715755, 6752.527323087336, 6387.169667943138, 6425.293217745951, 6465.353464653497, 6502.414782669583, 6529.967350163219, 6354.205724284465, 6371.203599550056, 6431.614103153825, 6441.806745797634, 6456.192975878015, 6232.096346029891, 6257.311695713377, 6270.4670103039925, 6274.027525733519, 6279.434850863444, 5761.539076873756, 5789.507891829242, 5821.76712931478, 5828.0966450200285, 5978.850528736642, 6110.297315808739, 6111.297200821785, 6129.570930034854, 6150.200473938359, 6184.257889053342], "unit": "ms", "name": "mootools.html", "value": 3975.3277148837556}, {"lowerIsBetter": false, "replicates": [301.34307210281594, 310.6194911233739, 312.28175197046795, 312.6888745698031, 314.46540880503153, 5332.066888294552, 5445.373782015069, 5507.311586051744, 5514.751836167372, 5516.255305533752, 5402.108652072413, 5410.377806552247, 5410.594205434599, 5411.485908838664, 5414.998225328307, 4076.6331030207275, 4147.294959856817, 4236.385724070008, 4243.469566304212, 4251.5535868733805, 4146.336586146217, 4166.812493437803, 4272.679549033819, 4279.165562715256, 4293.549177336382, 4201.411802347674, 4231.736021228643, 4240.279152544075, 4246.299360605496, 4251.936220956688, 4021.537523184842, 4140.130572579762, 4232.978835105836, 4239.915201695964, 4250.043740158486, 3677.411614141751, 3746.194568167857, 3755.830987605564, 3766.472693822867, 3771.0, 5199.324087868553, 5209.661372010845, 5210.843674689765, 5213.921791173136, 5215.0, 4858.1012512685265, 4878.682885612424, 4888.388951381077, 4889.997550502174, 4893.828715994959, 5602.1596760485845, 5709.25779648643, 5716.114002329646, 5721.227634269362, 5733.111367737965, 4090.6931980101313, 4091.89770255743, 4096.242195193869, 4096.610821971908, 4106.014556506447, 5989.460948514611, 6011.729472173719, 6016.759329626766, 6017.157597936292, 6017.217761690996, 4216.2199993001395, 4217.093324935092, 4218.409422680827, 4220.430241917364, 4220.577942205816, 3994.360902255625, 4113.753174809521, 4280.464941882265, 4282.614564689193, 4286.914261714748, 4720.457147428021, 4742.834000809955, 4769.952300476951, 4773.832915847928, 4775.188218002948, 5731.885362292731, 5739.971300143473, 5746.166805813134, 5748.942510574924, 5750.108733146369, 1452.3028946105928, 1474.3660226102663, 1475.4098360655823, 1475.527831094061, 1477.4016523308078, 990.9256805739599, 992.5186284651938, 993.011953106649, 1006.1296978113879, 1011.231464087299, 4982.626303027288, 5009.148444764399, 5010.824621138243, 5018.874528136753, 5020.347354843847, 5929.703514824241, 5930.822075337746, 5933.643981361132, 5935.821925342247, 5940.8415359004575, 4990.951900100947, 4991.97664478781, 4997.925446029121, 5001.049800537959, 5002.824901128443, 3116.454620441459, 3176.888808891678, 3206.9679303206667, 3209.8395080245896, 3212.9718490083415, 5586.106223004381, 5589.273394458694, 5593.021221286259, 5600.243967064475, 5603.243562119062, 6085.847853803691, 6093.299270583851, 6097.634141951497, 6101.511879049665, 6110.144579758838, 5476.0, 5578.63738856973, 5587.357453892773, 5590.636608620427, 5601.579881508903, 5858.2677165354335, 5923.466887980103, 5926.881462370642, 5939.613925094855, 5947.494462970696, 5801.1878337032, 5806.303243610793, 5807.854803629774, 5810.215620891126, 5813.128030795246, 5590.496855283044, 5598.496135347838, 5600.663960162403, 5604.411536788579, 5607.130894711327, 3998.9202915213314, 4085.040015596392, 4103.0, 4106.67146628275, 4111.362738775495, 5901.439363260483, 5904.232449781501, 5906.114082887601, 5922.170896074467, 5925.496332811759, 5690.2887139107615, 5701.173329867063, 5708.885822283448, 5710.428957104256, 5711.457411546063, 5549.556035517068, 5693.9430605693415, 5701.572382071444, 5702.429757024431, 5708.058170401837, 5567.7494512747835, 5583.0, 5585.609007369445, 5588.077967135539, 5591.245181900392, 5544.889102217852, 5697.0, 5715.599908006399, 5744.569157313302, 5754.597178197486, 5433.945660543344, 5605.103183490622, 5606.467385598362, 5641.15382692583, 5646.096624540054], "unit": "ms", "name": "prototype.html", "value": 4303.149564272715}, {"lowerIsBetter": false, "replicates": [717.3113810741688, 729.135973870963, 757.1217387830117, 797.397964536775, 813.1868131868132, 11023.61417350393, 11231.60689375873, 11448.771024579504, 11784.0, 11829.46767395467, 12069.517219311218, 12179.330136842493, 12185.0, 12188.085893557974, 12198.329091899943, 623.6476390839184, 631.9368063193667, 793.896793416855, 798.2376830127243, 812.5124925044985, 811.0956283743612, 811.4806523824727, 816.4040250617053, 816.6243527977108, 816.967321307147, 849.1847826086964, 850.2390360627235, 851.3657325292666, 857.691231156783, 857.9871301930476, 647.1102234427661, 658.8122385120241, 842.7176895739934, 867.5445391169624, 870.499462808881, 613.6962203709148, 619.8295468746086, 620.8354785981718, 620.9906851397233, 621.226572916717, 11615.593454229145, 11755.823662645067, 11787.0, 11803.586874459439, 11812.232204906653, 10436.530356133992, 10500.2649814513, 10882.891171088268, 11427.714307142305, 11876.881231187665, 8150.75547733569, 10021.39871607706, 10095.394276343442, 10293.536790844355, 10303.896961030368, 3200.7119359257777, 3232.159638493985, 3238.4494635911715, 3246.088899925503, 3297.0768184908266, 40252.19495610071, 40356.19287614261, 40401.39397909034, 41395.586044139476, 42676.78661606672, 9358.204552612968, 9482.810343793086, 9505.42967421957, 9530.666426675032, 9588.328816982745, 16566.66866662684, 16910.830891690926, 16912.915435422743, 16940.57648558796, 16971.406000789913, 6204.968975155186, 6369.331220221903, 6489.286178520359, 6577.769778057841, 6587.53887227899, 3620.131168519589, 3665.1020499977676, 3665.706743460517, 3674.3937250353392, 3758.1356288053903, 2689.784817214618, 2696.474187533412, 2702.8108032437935, 2710.6611673540806, 2724.9046283380385, 491.6189952786619, 494.0736119775421, 497.34847349971653, 500.47200203785354, 507.1935622360391, 573.5010540829421, 583.4661284924332, 593.4807043836643, 638.4062821575978, 638.4349850382445, 7812.687492500237, 8437.493750374997, 8472.49165050099, 8534.27458666008, 8535.103814099555, 501.7917564210812, 612.6599737145926, 628.5286035473395, 640.5420124610926, 640.5740182778493, 3581.982090089533, 3646.7447278690765, 3698.4822124902535, 3707.5550933888107, 3741.2704522618374, 52767.47232527703, 53421.46578534243, 53552.0, 53795.46204537905, 53916.730416347666, 44493.77753111214, 44769.0, 44971.32543011857, 45112.54887451084, 46519.767401162775, 40365.59634403618, 40446.393304100464, 40753.0, 41050.79474602608, 41085.58914410877, 7237.529560578546, 7302.707891684273, 7337.413006959324, 7439.55362678241, 7576.3181313682035, 30017.249568760082, 30274.69725302719, 30977.0, 31136.22159446032, 31314.843425782725, 37596.812015939744, 40811.0, 41057.58942410657, 41063.0, 41355.379669305585, 10136.0, 10275.948620256851, 10282.794344112926, 10283.897161028293, 10304.278700490893, 10994.175436842108, 11189.216754827085, 11239.10087193039, 11462.312261264351, 11556.0, 9932.851007235042, 10176.135028522658, 10248.180145588483, 10278.948605256926, 10504.054635082879, 10580.89419105799, 10832.5125369357, 10962.780744385227, 11134.3876086816, 11238.0, 10072.395656260647, 10390.22073344487, 10559.78880422372, 10616.256862019893, 10765.89234107649, 8980.191782739323, 9033.096690330914, 9069.954650226706, 9239.445633262027, 9475.573599187916, 8679.652813887626, 8813.60338784769, 8831.337649676429, 8999.0, 9020.368574199743], "unit": "ms", "name": "yui.html", "value": 5770.778718921488}], "name": "dromaeo_css", "value": 6313.68087740035}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 113.0, 105.0, 110.0, 111.0, 112.0, 99.0, 111.0, 116.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 109.9}, {"lowerIsBetter": true, "replicates": [153.0, 130.0, 158.0, 169.0, 131.0, 155.0, 162.0, 136.0, 163.0, 131.0], "unit": "ms", "name": "audio-beat-detection", "value": 148.8}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 162.0, 161.0, 161.0, 161.0, 162.0, 162.0, 162.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 161.5}, {"lowerIsBetter": true, "replicates": [74.0, 75.0, 84.0, 92.0, 72.0, 73.0, 72.0, 94.0, 93.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 80.1}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 131.0, 91.0, 92.0, 92.0, 124.0, 91.0, 91.0, 130.0], "unit": "ms", "name": "audio-oscillator", "value": 102.6}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 147.0, 147.0, 146.0, 147.0, 146.0, 147.0, 146.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.1}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 69.0, 69.0, 69.0, 70.0, 69.0, 78.0, 67.0, 67.0], "unit": "ms", "name": "json-parse-financial", "value": 69.5}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 68.0, 68.0, 68.0, 69.0, 68.0, 68.0, 68.0, 74.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.8}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 84.0, 86.0, 86.0, 86.0, 84.0, 82.0, 94.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.6}, {"lowerIsBetter": true, "replicates": [127.0, 125.0, 118.0, 127.0, 118.0, 122.0, 121.0, 128.0, 121.0, 129.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 123.6}, {"lowerIsBetter": true, "replicates": [145.0, 134.0, 145.0, 145.0, 149.0, 134.0, 147.0, 146.0, 134.0, 134.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 141.3}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 68.0, 69.0, 69.0, 68.0, 73.0, 69.0, 68.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.2}], "name": "kraken", "value": 1511.8}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [163.47882949158085], "unit": "score", "name": "Richards", "value": 215.94233399999993}, {"lowerIsBetter": false, "replicates": [191.16803670426305], "unit": "score", "name": "DeltaBlue", "value": 345.8632580000001}, {"lowerIsBetter": false, "replicates": [279.4076557697681], "unit": "score", "name": "Encrypt", "value": 952.6617989999997}, {"lowerIsBetter": false, "replicates": [5050.50505050505], "unit": "score", "name": "Decrypt", "value": 52.70383799999996}, {"lowerIsBetter": false, "replicates": [1990.0596421471173], "unit": "score", "name": "RayTrace", "value": 371.84262437562455}, {"lowerIsBetter": false, "replicates": [793.0214115781126], "unit": "score", "name": "Earley", "value": 840.4098429999997}, {"lowerIsBetter": false, "replicates": [12432.098765432098], "unit": "score", "name": "Boyer", "value": 53.608245283018846}, {"lowerIsBetter": false, "replicates": [27027.027027027027], "unit": "score", "name": "RegExp", "value": 33.70644499999999}, {"lowerIsBetter": false, "replicates": [603.9544637507489], "unit": "score", "name": "Splay", "value": 134.9290466269841}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 19769.17862791435}]} 09:17:53 INFO - RETURN: dromaeo_css: 6313.68 09:17:53 INFO - RETURN: kraken: 1511.80 09:17:53 INFO - RETURN: v8_7: 19769.18 09:17:53 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19769.18"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1511.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6313.68"}}} 09:17:53 INFO - Return code: 0 09:17:53 INFO - # TBPL SUCCESS # 09:17:53 INFO - Running post-action listener: _resource_record_post_action 09:17:53 INFO - Running post-run listener: _resource_record_post_run 09:17:54 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 4096; Write bytes: 495411200; Read time: 12; Write time: 882844 09:17:54 INFO - install - Wall time: 14s; CPU: 18.0%; Read bytes: 0; Write bytes: 214781952; Read time: 0; Write time: 592916 09:17:54 INFO - run-tests - Wall time: 1222s; CPU: 13.0%; Read bytes: 4096; Write bytes: 280272896; Read time: 12; Write time: 289884 09:17:54 INFO - Running post-run listener: _upload_blobber_files 09:17:54 INFO - Blob upload gear active. 09:17:54 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 09:17:54 INFO - Copying logs to upload dir... 09:17:54 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1277.378450 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-11-20 09:17:54.236582) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 09:17:54.240683) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1448038595.487458-1567052119 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/uaCOO9oFQL-duv7raIGe1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010003 build_url: 'https://queue.taskcluster.net/v1/task/uaCOO9oFQL-duv7raIGe1Q/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-20 09:17:54.293797) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 09:17:54.294201) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1448038595.487458-1567052119 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004510 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 09:17:54.344875) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 09:17:54.345233) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 09:17:54.345541) ========= ========= Total master_lag: 0.22 =========