builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-015 starttime: 1448062788.84 results: success (0) buildid: 20151120142833 builduid: 30b59426512a4f10843b1e0104c3318a revision: 106bfad77bf44d39fc334b336b037a70c2130d52 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 15:39:48.845279) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 15:39:48.845974) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 15:39:48.846258) ========= 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=70a720fcaf18edea6683c2dc000001ad-1448058753.669034-1042241014 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.009296 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 15:39:48.874212) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 15:39:48.874482) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 15:39:48.911028) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 15:39:48.911303) ========= 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=70a720fcaf18edea6683c2dc000001ad-1448058753.669034-1042241014 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004544 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 15:39:48.968558) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 15:39:48.968875) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 15:39:48.969514) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 15:39:48.969822) ========= 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=70a720fcaf18edea6683c2dc000001ad-1448058753.669034-1042241014 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-20 15:39:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 79.1M=0s 2015-11-20 15:39:49 (79.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.178006 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 15:39:49.161220) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 15:39:49.161498) ========= 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=70a720fcaf18edea6683c2dc000001ad-1448058753.669034-1042241014 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017781 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 15:39:49.210127) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-20 15:39:49.210437) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 106bfad77bf44d39fc334b336b037a70c2130d52 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 106bfad77bf44d39fc334b336b037a70c2130d52 --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=70a720fcaf18edea6683c2dc000001ad-1448058753.669034-1042241014 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-20 15:39:49,485 truncating revision to first 12 chars 2015-11-20 15:39:49,485 Setting DEBUG logging. 2015-11-20 15:39:49,485 attempt 1/10 2015-11-20 15:39:49,485 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/106bfad77bf4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-20 15:39:50,581 unpacking tar archive at: mozilla-central-106bfad77bf4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.371633 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-20 15:39:50.594660) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 15:39:50.595015) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 15:39:50.603127) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 15:39:50.603383) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 15:39:50.603772) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2015-11-20 15:39:50.604074) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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', 'Firefox-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=70a720fcaf18edea6683c2dc000001ad-1448058753.669034-1042241014 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:39:50 INFO - MultiFileLogger online at 20151120 15:39:50 in /builds/slave/test 15:39:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 15:39:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:39:50 INFO - {'append_to_log': False, 15:39:50 INFO - 'base_work_dir': '/builds/slave/test', 15:39:50 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 15:39:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:39:50 INFO - 'branch': 'Firefox-Non-PGO', 15:39:50 INFO - 'buildbot_json_path': 'buildprops.json', 15:39:50 INFO - 'config_files': ('talos/linux_config.py',), 15:39:50 INFO - 'default_actions': ('clobber', 15:39:50 INFO - 'read-buildbot-config', 15:39:50 INFO - 'download-and-extract', 15:39:50 INFO - 'populate-webroot', 15:39:50 INFO - 'create-virtualenv', 15:39:50 INFO - 'install', 15:39:50 INFO - 'run-tests'), 15:39:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:39:50 INFO - 'download_minidump_stackwalk': True, 15:39:50 INFO - 'download_symbols': 'ondemand', 15:39:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:39:50 INFO - 'tooltool.py': '/tools/tooltool.py', 15:39:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:39:50 INFO - '/tools/misc-python/virtualenv.py')}, 15:39:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:39:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:39:50 INFO - 'installer_path': 'installer.exe', 15:39:50 INFO - 'log_level': 'info', 15:39:50 INFO - 'log_name': 'talos', 15:39:50 INFO - 'log_to_console': True, 15:39:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:39:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:39:50 INFO - 'opt_config_files': (), 15:39:50 INFO - 'pip_index': False, 15:39:50 INFO - 'sps_profile': False, 15:39:50 INFO - 'sps_profile_interval': 0, 15:39:50 INFO - 'suite': 'dromaeojs', 15:39:50 INFO - 'system_bits': '64', 15:39:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:39:50 INFO - 'title': 'talos-linux64-ix-015', 15:39:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:39:50 INFO - 'use_talos_json': True, 15:39:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:39:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:39:50 INFO - 'work_dir': 'build'} 15:39:50 INFO - ##### 15:39:50 INFO - ##### Running clobber step. 15:39:50 INFO - ##### 15:39:50 INFO - Running pre-action listener: _resource_record_pre_action 15:39:50 INFO - Running main action method: clobber 15:39:50 INFO - rmtree: /builds/slave/test/build 15:39:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:39:51 INFO - Running post-action listener: _resource_record_post_action 15:39:51 INFO - ##### 15:39:51 INFO - ##### Running read-buildbot-config step. 15:39:51 INFO - ##### 15:39:51 INFO - Running pre-action listener: _resource_record_pre_action 15:39:51 INFO - Running main action method: read_buildbot_config 15:39:51 INFO - Using buildbot properties: 15:39:51 INFO - { 15:39:51 INFO - "properties": { 15:39:51 INFO - "buildnumber": 217, 15:39:51 INFO - "product": "firefox", 15:39:51 INFO - "script_repo_revision": "production", 15:39:51 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 15:39:51 INFO - "repository": "", 15:39:51 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 15:39:51 INFO - "buildid": "20151120142833", 15:39:51 INFO - "slavename": "talos-linux64-ix-015", 15:39:51 INFO - "pgo_build": "False", 15:39:51 INFO - "basedir": "/builds/slave/test", 15:39:51 INFO - "project": "", 15:39:51 INFO - "platform": "ubuntu64_hw", 15:39:51 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:39:51 INFO - "slavebuilddir": "test", 15:39:51 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 15:39:51 INFO - "branch": "mozilla-central", 15:39:51 INFO - "repo_path": "mozilla-central", 15:39:51 INFO - "stage_platform": "linux64", 15:39:51 INFO - "builduid": "30b59426512a4f10843b1e0104c3318a", 15:39:51 INFO - "revision": "106bfad77bf44d39fc334b336b037a70c2130d52" 15:39:51 INFO - }, 15:39:51 INFO - "sourcestamp": { 15:39:51 INFO - "repository": "", 15:39:51 INFO - "hasPatch": false, 15:39:51 INFO - "project": "", 15:39:51 INFO - "branch": "mozilla-central-linux64-talos", 15:39:51 INFO - "changes": [ 15:39:51 INFO - { 15:39:51 INFO - "category": null, 15:39:51 INFO - "files": [ 15:39:51 INFO - { 15:39:51 INFO - "url": null, 15:39:51 INFO - "name": "https://queue.taskcluster.net/v1/task/mwZ-J9TvQv2DFIRp0f6H5g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 15:39:51 INFO - } 15:39:51 INFO - ], 15:39:51 INFO - "repository": "", 15:39:51 INFO - "rev": "106bfad77bf44d39fc334b336b037a70c2130d52", 15:39:51 INFO - "who": "kwierso@gmail.com", 15:39:51 INFO - "when": 1448062750, 15:39:51 INFO - "number": 6691051, 15:39:51 INFO - "comments": "Bug 1226648 - Flame-kk device tests should be disabled r=jlorenzo", 15:39:51 INFO - "project": "", 15:39:51 INFO - "at": "Fri 20 Nov 2015 15:39:10", 15:39:51 INFO - "branch": "mozilla-central-linux64-talos", 15:39:51 INFO - "revlink": "", 15:39:51 INFO - "properties": [ 15:39:51 INFO - [ 15:39:51 INFO - "buildid", 15:39:51 INFO - "20151120142833", 15:39:51 INFO - "Change" 15:39:51 INFO - ], 15:39:51 INFO - [ 15:39:51 INFO - "builduid", 15:39:51 INFO - "30b59426512a4f10843b1e0104c3318a", 15:39:51 INFO - "Change" 15:39:51 INFO - ], 15:39:51 INFO - [ 15:39:51 INFO - "pgo_build", 15:39:51 INFO - "False", 15:39:51 INFO - "Change" 15:39:51 INFO - ] 15:39:51 INFO - ], 15:39:51 INFO - "revision": "106bfad77bf44d39fc334b336b037a70c2130d52" 15:39:51 INFO - } 15:39:51 INFO - ], 15:39:51 INFO - "revision": "106bfad77bf44d39fc334b336b037a70c2130d52" 15:39:51 INFO - } 15:39:51 INFO - } 15:39:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/mwZ-J9TvQv2DFIRp0f6H5g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 15:39:51 INFO - Running post-action listener: _resource_record_post_action 15:39:51 INFO - ##### 15:39:51 INFO - ##### Running download-and-extract step. 15:39:51 INFO - ##### 15:39:51 INFO - Running pre-action listener: _resource_record_pre_action 15:39:51 INFO - Running main action method: download_and_extract 15:39:51 INFO - mkdir: /builds/slave/test/build/tests 15:39:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:39:51 INFO - https://queue.taskcluster.net/v1/task/mwZ-J9TvQv2DFIRp0f6H5g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:39:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mwZ-J9TvQv2DFIRp0f6H5g/artifacts/public/build/test_packages.json 15:39:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mwZ-J9TvQv2DFIRp0f6H5g/artifacts/public/build/test_packages.json 15:39:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mwZ-J9TvQv2DFIRp0f6H5g/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 15:39:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mwZ-J9TvQv2DFIRp0f6H5g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 15:39:54 INFO - Downloaded 1302 bytes. 15:39:54 INFO - Reading from file /builds/slave/test/build/test_packages.json 15:39:54 INFO - Using the following test package requirements: 15:39:54 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 15:39:54 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:39:54 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:39:54 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:39:54 INFO - u'jsshell-linux-x86_64.zip'], 15:39:54 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:39:54 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:39:54 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 15:39:54 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:39:54 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:39:54 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:39:54 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:39:54 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:39:54 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:39:54 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 15:39:54 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:39:54 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:39:54 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:39:54 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')]} 15:39:54 INFO - https://queue.taskcluster.net/v1/task/mwZ-J9TvQv2DFIRp0f6H5g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:39:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mwZ-J9TvQv2DFIRp0f6H5g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:39:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mwZ-J9TvQv2DFIRp0f6H5g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:39:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mwZ-J9TvQv2DFIRp0f6H5g/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 15:39:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mwZ-J9TvQv2DFIRp0f6H5g/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 15:39:56 INFO - Downloaded 21340046 bytes. 15:39:56 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 15:39:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:39:56 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 15:39:57 INFO - Return code: 0 15:39:57 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 15:39:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:39:57 INFO - https://queue.taskcluster.net/v1/task/mwZ-J9TvQv2DFIRp0f6H5g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:39:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mwZ-J9TvQv2DFIRp0f6H5g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:39:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mwZ-J9TvQv2DFIRp0f6H5g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:39:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mwZ-J9TvQv2DFIRp0f6H5g/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 15:39:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mwZ-J9TvQv2DFIRp0f6H5g/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 15:40:04 INFO - Downloaded 21340046 bytes. 15:40:04 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 15:40:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:40:04 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 15:40:05 INFO - Return code: 0 15:40: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')]} 15:40:05 INFO - https://queue.taskcluster.net/v1/task/mwZ-J9TvQv2DFIRp0f6H5g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:40:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mwZ-J9TvQv2DFIRp0f6H5g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 15:40:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mwZ-J9TvQv2DFIRp0f6H5g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 15:40:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mwZ-J9TvQv2DFIRp0f6H5g/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 15:40:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mwZ-J9TvQv2DFIRp0f6H5g/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 15:40:07 INFO - Downloaded 11130997 bytes. 15:40:07 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 15:40:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 15:40:07 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 15:40:07 INFO - Return code: 0 15:40: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')]} 15:40:07 INFO - https://queue.taskcluster.net/v1/task/mwZ-J9TvQv2DFIRp0f6H5g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:40:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mwZ-J9TvQv2DFIRp0f6H5g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:40:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mwZ-J9TvQv2DFIRp0f6H5g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:40:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mwZ-J9TvQv2DFIRp0f6H5g/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 15:40:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mwZ-J9TvQv2DFIRp0f6H5g/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 15:40:10 INFO - Downloaded 55786538 bytes. 15:40:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/mwZ-J9TvQv2DFIRp0f6H5g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:40:10 INFO - mkdir: /builds/slave/test/properties 15:40:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:40:10 INFO - Writing to file /builds/slave/test/properties/build_url 15:40:10 INFO - Contents: 15:40:10 INFO - build_url:https://queue.taskcluster.net/v1/task/mwZ-J9TvQv2DFIRp0f6H5g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:40:10 INFO - Running post-action listener: _resource_record_post_action 15:40:10 INFO - Running post-action listener: set_extra_try_arguments 15:40:10 INFO - ##### 15:40:10 INFO - ##### Running populate-webroot step. 15:40:10 INFO - ##### 15:40:10 INFO - Running pre-action listener: _resource_record_pre_action 15:40:10 INFO - Running main action method: populate_webroot 15:40:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:40:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:40:10 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 15:40:10 INFO - '../fennec_ids.txt'], 15:40:10 INFO - 'tests': ['tcheck2']}, 15:40:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:40:10 INFO - '--tppagecycles', 15:40:10 INFO - '7'], 15:40:10 INFO - 'tests': ['tsvgm']}}, 15:40:10 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:40:10 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:40:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:40:10 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:40:10 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:40:10 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:40:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:40:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:40:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:40:10 INFO - 'talos_options': ['--e10s'], 15:40:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:40:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:40:10 INFO - 'tests': ['damp', 'tps']}, 15:40:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:40:10 INFO - 'talos_options': ['--e10s'], 15:40:10 INFO - 'tests': ['damp', 'tps']}, 15:40:10 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:40:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:40:10 INFO - 'other': {'tests': ['a11yr', 15:40:10 INFO - 'ts_paint', 15:40:10 INFO - 'tpaint', 15:40:10 INFO - 'sessionrestore', 15:40:10 INFO - 'sessionrestore_no_auto_restore']}, 15:40:10 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:40:10 INFO - 'tests': ['a11yr', 15:40:10 INFO - 'ts_paint', 15:40:10 INFO - 'tpaint', 15:40:10 INFO - 'sessionrestore', 15:40:10 INFO - 'sessionrestore_no_auto_restore']}, 15:40:10 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:40:10 INFO - 'tests': ['a11yr', 15:40:10 INFO - 'ts_paint', 15:40:10 INFO - 'tpaint', 15:40:10 INFO - 'sessionrestore', 15:40:10 INFO - 'sessionrestore_no_auto_restore']}, 15:40:10 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:40:10 INFO - 'tests': ['a11yr', 15:40:10 INFO - 'ts_paint', 15:40:10 INFO - 'tpaint', 15:40:10 INFO - 'sessionrestore', 15:40:10 INFO - 'sessionrestore_no_auto_restore']}, 15:40:10 INFO - 'other_l64': {'tests': ['a11yr', 15:40:10 INFO - 'ts_paint', 15:40:10 INFO - 'tpaint', 15:40:10 INFO - 'sessionrestore', 15:40:10 INFO - 'sessionrestore_no_auto_restore']}, 15:40:10 INFO - 'other_nol64': {'tests': ['a11yr', 15:40:10 INFO - 'ts_paint', 15:40:10 INFO - 'tpaint', 15:40:10 INFO - 'sessionrestore', 15:40:10 INFO - 'sessionrestore_no_auto_restore']}, 15:40:10 INFO - 'svgr': {'tests': ['tsvgx', 15:40:10 INFO - 'tsvgr_opacity', 15:40:10 INFO - 'tart', 15:40:10 INFO - 'tscrollx', 15:40:10 INFO - 'cart']}, 15:40:10 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:40:10 INFO - 'tests': ['tsvgx', 15:40:10 INFO - 'tsvgr_opacity', 15:40:10 INFO - 'tart', 15:40:10 INFO - 'tscrollx', 15:40:10 INFO - 'cart']}, 15:40:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:40:10 INFO - 'tests': ['tp5o']}, 15:40:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:40:10 INFO - 'talos_options': ['--e10s'], 15:40:10 INFO - 'tests': ['tp5o']}, 15:40:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:40:10 INFO - 'talos_options': ['--xperf_path', 15:40:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:40:10 INFO - 'tests': ['tp5n']}, 15:40:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:40:10 INFO - 'talos_options': ['--e10s', 15:40:10 INFO - '--xperf_path', 15:40:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:40:10 INFO - 'tests': ['tp5n']}}, 15:40:10 INFO - 'talos.zip': {'path': '', 15:40:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:40:10 INFO - Running post-action listener: _resource_record_post_action 15:40:10 INFO - ##### 15:40:10 INFO - ##### Running create-virtualenv step. 15:40:10 INFO - ##### 15:40:10 INFO - Running pre-action listener: _resource_record_pre_action 15:40:10 INFO - Running main action method: create_virtualenv 15:40:10 INFO - Creating virtualenv /builds/slave/test/build/venv 15:40:10 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 15:40:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:40:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:40:10 INFO - Using real prefix '/usr' 15:40:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:40:10 INFO - Installing distribute.............................................................................................................................................................................................done. 15:40:12 INFO - Installing pip.................done. 15:40:12 INFO - Return code: 0 15:40:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:40:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:40:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:40:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:40:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:40:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:40:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:40:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7f5c28d38c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5a6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c0b900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c51b70>, '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 0x1ca2dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca3250>, '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': '70a720fcaf18edea6683c2dc000001ad-1448058753.669034-1042241014', '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 15:40:12 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 15:40:12 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 15:40:12 INFO - Using env: {'DISPLAY': ':0', 15:40:12 INFO - 'HOME': '/home/cltbld', 15:40:12 INFO - 'LANG': 'en_US.UTF-8', 15:40:12 INFO - 'LANGUAGE': 'en_US:en', 15:40:12 INFO - 'LOGNAME': 'cltbld', 15:40:12 INFO - 'MAIL': '/var/mail/cltbld', 15:40:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:12 INFO - 'MOZ_NO_REMOTE': '1', 15:40:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:12 INFO - 'NO_EM_RESTART': '1', 15:40:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:12 INFO - 'PWD': '/builds/slave/test', 15:40:12 INFO - 'SHELL': '/bin/bash', 15:40:12 INFO - 'SHLVL': '1', 15:40:12 INFO - 'TERM': 'linux', 15:40:12 INFO - 'TMOUT': '86400', 15:40:12 INFO - 'USER': 'cltbld', 15:40:12 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1448058753.669034-1042241014', 15:40:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:12 INFO - '_': '/tools/buildbot/bin/python'} 15:40:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:40:12 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 15:40:12 INFO - Cleaning up... 15:40:12 INFO - Return code: 0 15:40:12 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:40:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:40:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:40:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:40:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:40:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:40:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:40:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7f5c28d38c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5a6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c0b900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c51b70>, '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 0x1ca2dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca3250>, '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': '70a720fcaf18edea6683c2dc000001ad-1448058753.669034-1042241014', '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 15:40:12 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 15:40:12 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 15:40:12 INFO - Using env: {'DISPLAY': ':0', 15:40:12 INFO - 'HOME': '/home/cltbld', 15:40:12 INFO - 'LANG': 'en_US.UTF-8', 15:40:12 INFO - 'LANGUAGE': 'en_US:en', 15:40:12 INFO - 'LOGNAME': 'cltbld', 15:40:12 INFO - 'MAIL': '/var/mail/cltbld', 15:40:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:12 INFO - 'MOZ_NO_REMOTE': '1', 15:40:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:12 INFO - 'NO_EM_RESTART': '1', 15:40:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:12 INFO - 'PWD': '/builds/slave/test', 15:40:12 INFO - 'SHELL': '/bin/bash', 15:40:12 INFO - 'SHLVL': '1', 15:40:12 INFO - 'TERM': 'linux', 15:40:12 INFO - 'TMOUT': '86400', 15:40:12 INFO - 'USER': 'cltbld', 15:40:12 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1448058753.669034-1042241014', 15:40:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:12 INFO - '_': '/tools/buildbot/bin/python'} 15:40:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:40:13 INFO - Downloading/unpacking psutil>=0.7.1 15:40:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:40:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:40:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:40:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:40:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:14 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 15:40:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 15:40:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:40:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:40:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:40:14 INFO - Installing collected packages: psutil 15:40:14 INFO - Running setup.py install for psutil 15:40:14 INFO - building 'psutil._psutil_linux' extension 15:40:14 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 15:40:15 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 15:40:15 INFO - building 'psutil._psutil_posix' extension 15:40:15 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 15:40:15 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 15:40:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:40:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:40:15 INFO - Successfully installed psutil 15:40:15 INFO - Cleaning up... 15:40:15 INFO - Return code: 0 15:40:15 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:40:15 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')]} 15:40:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:40:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:40:15 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')]} 15:40:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:40:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:40:15 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 0x7f5c28d38c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5a6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c0b900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c51b70>, '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 0x1ca2dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca3250>, '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': '70a720fcaf18edea6683c2dc000001ad-1448058753.669034-1042241014', '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 15:40:15 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 15:40:15 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 15:40:15 INFO - Using env: {'DISPLAY': ':0', 15:40:15 INFO - 'HOME': '/home/cltbld', 15:40:15 INFO - 'LANG': 'en_US.UTF-8', 15:40:15 INFO - 'LANGUAGE': 'en_US:en', 15:40:15 INFO - 'LOGNAME': 'cltbld', 15:40:15 INFO - 'MAIL': '/var/mail/cltbld', 15:40:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:15 INFO - 'MOZ_NO_REMOTE': '1', 15:40:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:15 INFO - 'NO_EM_RESTART': '1', 15:40:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:15 INFO - 'PWD': '/builds/slave/test', 15:40:15 INFO - 'SHELL': '/bin/bash', 15:40:15 INFO - 'SHLVL': '1', 15:40:15 INFO - 'TERM': 'linux', 15:40:15 INFO - 'TMOUT': '86400', 15:40:15 INFO - 'USER': 'cltbld', 15:40:15 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1448058753.669034-1042241014', 15:40:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:15 INFO - '_': '/tools/buildbot/bin/python'} 15:40:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:40:15 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:40: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 15:40: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 15:40: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 15:40: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 15:40: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 15:40: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 15:40:17 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:40:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 15:40:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:40:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:40:17 INFO - Installing collected packages: mozsystemmonitor 15:40:17 INFO - Running setup.py install for mozsystemmonitor 15:40:17 INFO - Successfully installed mozsystemmonitor 15:40:17 INFO - Cleaning up... 15:40:17 INFO - Return code: 0 15:40:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:40: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')]} 15:40:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:40:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:40: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')]} 15:40:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:40:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:40: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', '--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 0x7f5c28d38c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5a6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c0b900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c51b70>, '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 0x1ca2dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca3250>, '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': '70a720fcaf18edea6683c2dc000001ad-1448058753.669034-1042241014', '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 15:40:17 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 15:40:17 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 15:40:17 INFO - Using env: {'DISPLAY': ':0', 15:40:17 INFO - 'HOME': '/home/cltbld', 15:40:17 INFO - 'LANG': 'en_US.UTF-8', 15:40:17 INFO - 'LANGUAGE': 'en_US:en', 15:40:17 INFO - 'LOGNAME': 'cltbld', 15:40:17 INFO - 'MAIL': '/var/mail/cltbld', 15:40:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:17 INFO - 'MOZ_NO_REMOTE': '1', 15:40:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:17 INFO - 'NO_EM_RESTART': '1', 15:40:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:17 INFO - 'PWD': '/builds/slave/test', 15:40:17 INFO - 'SHELL': '/bin/bash', 15:40:17 INFO - 'SHLVL': '1', 15:40:17 INFO - 'TERM': 'linux', 15:40:17 INFO - 'TMOUT': '86400', 15:40:17 INFO - 'USER': 'cltbld', 15:40:17 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1448058753.669034-1042241014', 15:40:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:17 INFO - '_': '/tools/buildbot/bin/python'} 15:40:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:40:17 INFO - Downloading/unpacking blobuploader==1.2.4 15:40:17 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 15:40:17 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 15:40:17 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 15:40:17 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 15:40:17 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 15:40:17 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 15:40:19 INFO - Downloading blobuploader-1.2.4.tar.gz 15:40:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 15:40:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:40:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:40:19 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 15:40:19 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 15:40:19 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 15:40:19 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 15:40:19 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 15:40:19 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 15:40:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 15:40:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:40:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:40:19 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 15:40:19 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 15:40:19 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 15:40:19 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 15:40:19 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 15:40:19 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 15:40:19 INFO - Downloading docopt-0.6.1.tar.gz 15:40:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 15:40:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:40:20 INFO - Installing collected packages: blobuploader, requests, docopt 15:40:20 INFO - Running setup.py install for blobuploader 15:40:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:40:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:40:20 INFO - Running setup.py install for requests 15:40:20 INFO - Running setup.py install for docopt 15:40:20 INFO - Successfully installed blobuploader requests docopt 15:40:20 INFO - Cleaning up... 15:40:20 INFO - Return code: 0 15:40:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:40:20 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')]} 15:40:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:40:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:40:20 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')]} 15:40:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:40:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:40:20 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 0x7f5c28d38c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5a6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c0b900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c51b70>, '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 0x1ca2dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca3250>, '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': '70a720fcaf18edea6683c2dc000001ad-1448058753.669034-1042241014', '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 15:40:20 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 15:40:20 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 15:40:20 INFO - Using env: {'DISPLAY': ':0', 15:40:20 INFO - 'HOME': '/home/cltbld', 15:40:20 INFO - 'LANG': 'en_US.UTF-8', 15:40:20 INFO - 'LANGUAGE': 'en_US:en', 15:40:20 INFO - 'LOGNAME': 'cltbld', 15:40:20 INFO - 'MAIL': '/var/mail/cltbld', 15:40:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:20 INFO - 'MOZ_NO_REMOTE': '1', 15:40:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:20 INFO - 'NO_EM_RESTART': '1', 15:40:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:20 INFO - 'PWD': '/builds/slave/test', 15:40:20 INFO - 'SHELL': '/bin/bash', 15:40:20 INFO - 'SHLVL': '1', 15:40:20 INFO - 'TERM': 'linux', 15:40:20 INFO - 'TMOUT': '86400', 15:40:20 INFO - 'USER': 'cltbld', 15:40:20 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1448058753.669034-1042241014', 15:40:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:20 INFO - '_': '/tools/buildbot/bin/python'} 15:40:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:40:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:40:20 INFO - Running setup.py (path:/tmp/pip-OItf78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:40:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:40:20 INFO - Running setup.py (path:/tmp/pip-nSXhOX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:40:21 INFO - Running setup.py (path:/tmp/pip-SkaqmA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:40:21 INFO - Running setup.py (path:/tmp/pip-LlpiA6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:40:21 INFO - Running setup.py (path:/tmp/pip-tLilDd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:40:21 INFO - Running setup.py (path:/tmp/pip-WaVlwd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:40:21 INFO - Running setup.py (path:/tmp/pip-_GgAuw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:40:21 INFO - Running setup.py (path:/tmp/pip-OP5eUG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:40:21 INFO - Running setup.py (path:/tmp/pip-3XksHL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:40:21 INFO - Running setup.py (path:/tmp/pip-8U423e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:40:21 INFO - Running setup.py (path:/tmp/pip-u4xAh0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:40:21 INFO - Running setup.py (path:/tmp/pip-XJUaud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:40:21 INFO - Running setup.py (path:/tmp/pip-z9dxvT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:40:21 INFO - Running setup.py (path:/tmp/pip-PxoWYr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:40:21 INFO - Running setup.py (path:/tmp/pip-BX6Cnt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:40:21 INFO - Running setup.py (path:/tmp/pip-lzmqGZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:40:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:40:22 INFO - Running setup.py (path:/tmp/pip-7TNcdR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:40:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:40:22 INFO - Running setup.py install for manifestparser 15:40:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:40:22 INFO - Running setup.py install for mozcrash 15:40:22 INFO - Running setup.py install for mozdebug 15:40:22 INFO - Running setup.py install for mozdevice 15:40:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:40:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:40:22 INFO - Running setup.py install for mozfile 15:40:22 INFO - Running setup.py install for mozhttpd 15:40:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:40:22 INFO - Running setup.py install for mozinfo 15:40:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:40:22 INFO - Running setup.py install for mozInstall 15:40:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:40:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:40:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:40:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:40:22 INFO - Running setup.py install for mozleak 15:40:22 INFO - Running setup.py install for mozlog 15:40:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:40:23 INFO - Running setup.py install for moznetwork 15:40:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:40:23 INFO - Running setup.py install for mozprocess 15:40:23 INFO - Running setup.py install for mozprofile 15:40:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:40:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:40:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:40:23 INFO - Running setup.py install for mozrunner 15:40:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:40:23 INFO - Running setup.py install for mozscreenshot 15:40:23 INFO - Running setup.py install for moztest 15:40:23 INFO - Running setup.py install for mozversion 15:40:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:40:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:40:23 INFO - Cleaning up... 15:40:23 INFO - Return code: 0 15:40:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:40:23 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')]} 15:40:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:40:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:40:23 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')]} 15:40:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:40:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:40:23 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 0x7f5c28d38c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5a6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c0b900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c51b70>, '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 0x1ca2dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca3250>, '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': '70a720fcaf18edea6683c2dc000001ad-1448058753.669034-1042241014', '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 15:40:23 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 15:40:23 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 15:40:23 INFO - Using env: {'DISPLAY': ':0', 15:40:23 INFO - 'HOME': '/home/cltbld', 15:40:23 INFO - 'LANG': 'en_US.UTF-8', 15:40:23 INFO - 'LANGUAGE': 'en_US:en', 15:40:23 INFO - 'LOGNAME': 'cltbld', 15:40:23 INFO - 'MAIL': '/var/mail/cltbld', 15:40:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:23 INFO - 'MOZ_NO_REMOTE': '1', 15:40:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:23 INFO - 'NO_EM_RESTART': '1', 15:40:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:23 INFO - 'PWD': '/builds/slave/test', 15:40:23 INFO - 'SHELL': '/bin/bash', 15:40:23 INFO - 'SHLVL': '1', 15:40:23 INFO - 'TERM': 'linux', 15:40:23 INFO - 'TMOUT': '86400', 15:40:23 INFO - 'USER': 'cltbld', 15:40:23 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1448058753.669034-1042241014', 15:40:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:23 INFO - '_': '/tools/buildbot/bin/python'} 15:40:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:40:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:40:24 INFO - Running setup.py (path:/tmp/pip-JBkY0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:40:24 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)) 15:40:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:40:24 INFO - Running setup.py (path:/tmp/pip-BOBgu_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:40:24 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)) 15:40:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:40:24 INFO - Running setup.py (path:/tmp/pip-oQ1tvT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:40:24 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)) 15:40:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:40:24 INFO - Running setup.py (path:/tmp/pip-_GvywH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:40:24 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)) 15:40:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:40:24 INFO - Running setup.py (path:/tmp/pip-bbvkJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:40:24 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)) 15:40:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:40:24 INFO - Running setup.py (path:/tmp/pip-Bsc1zq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:40:24 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)) 15:40:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:40:24 INFO - Running setup.py (path:/tmp/pip-LZ1T8q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:40:24 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)) 15:40:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:40:24 INFO - Running setup.py (path:/tmp/pip-SqM8vV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:40:24 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)) 15:40:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:40:24 INFO - Running setup.py (path:/tmp/pip-EN7OK2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:40:24 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)) 15:40:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:40:24 INFO - Running setup.py (path:/tmp/pip-HflAmR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:40:24 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)) 15:40:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:40:24 INFO - Running setup.py (path:/tmp/pip-J5J7jB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:40:24 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)) 15:40:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:40:24 INFO - Running setup.py (path:/tmp/pip-T6y2nP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:40:24 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)) 15:40:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:40:24 INFO - Running setup.py (path:/tmp/pip-daxOdz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:40:25 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)) 15:40:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:40:25 INFO - Running setup.py (path:/tmp/pip-oinIYt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:40:25 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)) 15:40:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:40:25 INFO - Running setup.py (path:/tmp/pip-4Uboh4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:40:25 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)) 15:40:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:40:25 INFO - Running setup.py (path:/tmp/pip-eri9Ir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:40:25 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)) 15:40:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:40:25 INFO - Running setup.py (path:/tmp/pip-i_Wj0X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:40:25 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)) 15:40:25 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)) 15:40:25 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)) 15:40:25 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)) 15:40:25 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)) 15:40:25 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)) 15:40:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:40:25 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 15:40:25 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 15:40:25 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 15:40:25 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 15:40:25 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 15:40:25 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 15:40:26 INFO - Downloading blessings-1.5.1.tar.gz 15:40:26 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 15:40:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:40:27 INFO - Installing collected packages: blessings 15:40:27 INFO - Running setup.py install for blessings 15:40:27 INFO - Successfully installed blessings 15:40:27 INFO - Cleaning up... 15:40:27 INFO - Return code: 0 15:40:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:40:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:40:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:40:27 INFO - Reading from file tmpfile_stdout 15:40:27 INFO - Current package versions: 15:40:27 INFO - argparse == 1.2.1 15:40:27 INFO - blessings == 1.5.1 15:40:27 INFO - blobuploader == 1.2.4 15:40:27 INFO - docopt == 0.6.1 15:40:27 INFO - manifestparser == 1.1 15:40:27 INFO - mozInstall == 1.12 15:40:27 INFO - mozcrash == 0.16 15:40:27 INFO - mozdebug == 0.1 15:40:27 INFO - mozdevice == 0.47 15:40:27 INFO - mozfile == 1.2 15:40:27 INFO - mozhttpd == 0.7 15:40:27 INFO - mozinfo == 0.9 15:40:27 INFO - mozleak == 0.1 15:40:27 INFO - mozlog == 3.0 15:40:27 INFO - moznetwork == 0.27 15:40:27 INFO - mozprocess == 0.22 15:40:27 INFO - mozprofile == 0.27 15:40:27 INFO - mozrunner == 6.11 15:40:27 INFO - mozscreenshot == 0.1 15:40:27 INFO - mozsystemmonitor == 0.0 15:40:27 INFO - moztest == 0.7 15:40:27 INFO - mozversion == 1.4 15:40:27 INFO - psutil == 3.1.1 15:40:27 INFO - requests == 1.2.3 15:40:27 INFO - wsgiref == 0.1.2 15:40:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:40:27 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')]} 15:40:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:40:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:40:27 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')]} 15:40:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:40:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:40:27 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 0x7f5c28d38c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5a6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c0b900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c51b70>, '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 0x1ca2dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca3250>, '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': '70a720fcaf18edea6683c2dc000001ad-1448058753.669034-1042241014', '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 15:40:27 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 15:40:27 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 15:40:27 INFO - Using env: {'DISPLAY': ':0', 15:40:27 INFO - 'HOME': '/home/cltbld', 15:40:27 INFO - 'LANG': 'en_US.UTF-8', 15:40:27 INFO - 'LANGUAGE': 'en_US:en', 15:40:27 INFO - 'LOGNAME': 'cltbld', 15:40:27 INFO - 'MAIL': '/var/mail/cltbld', 15:40:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:27 INFO - 'MOZ_NO_REMOTE': '1', 15:40:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:27 INFO - 'NO_EM_RESTART': '1', 15:40:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:27 INFO - 'PWD': '/builds/slave/test', 15:40:27 INFO - 'SHELL': '/bin/bash', 15:40:27 INFO - 'SHLVL': '1', 15:40:27 INFO - 'TERM': 'linux', 15:40:27 INFO - 'TMOUT': '86400', 15:40:27 INFO - 'USER': 'cltbld', 15:40:27 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1448058753.669034-1042241014', 15:40:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:27 INFO - '_': '/tools/buildbot/bin/python'} 15:40:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:40:27 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)) 15:40:27 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)) 15:40:27 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)) 15:40:27 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)) 15:40:27 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)) 15:40:27 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)) 15:40:27 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)) 15:40:27 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)) 15:40:27 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)) 15:40:27 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)) 15:40:27 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)) 15:40:27 INFO - Cleaning up... 15:40:27 INFO - Return code: 0 15:40:27 INFO - Running post-action listener: _resource_record_post_action 15:40:27 INFO - Running post-action listener: _start_resource_monitoring 15:40:27 INFO - Starting resource monitoring. 15:40:27 INFO - ##### 15:40:27 INFO - ##### Running install step. 15:40:27 INFO - ##### 15:40:27 INFO - Running pre-action listener: _resource_record_pre_action 15:40:27 INFO - Running main action method: install 15:40:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:40:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:40:27 INFO - Reading from file tmpfile_stdout 15:40:27 INFO - Detecting whether we're running mozinstall >=1.0... 15:40:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:40:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:40:27 INFO - Reading from file tmpfile_stdout 15:40:27 INFO - Output received: 15:40:27 INFO - Usage: mozinstall [options] installer 15:40:27 INFO - Options: 15:40:27 INFO - -h, --help show this help message and exit 15:40:27 INFO - -d DEST, --destination=DEST 15:40:27 INFO - Directory to install application into. [default: 15:40:27 INFO - "/builds/slave/test"] 15:40:27 INFO - --app=APP Application being installed. [default: firefox] 15:40:27 INFO - mkdir: /builds/slave/test/build/application 15:40:27 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'] 15:40:27 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 15:40:42 INFO - Reading from file tmpfile_stdout 15:40:42 INFO - Output received: 15:40:42 INFO - /builds/slave/test/build/application/firefox/firefox 15:40:42 INFO - Running post-action listener: _resource_record_post_action 15:40:42 INFO - ##### 15:40:42 INFO - ##### Running run-tests step. 15:40:42 INFO - ##### 15:40:42 INFO - Running pre-action listener: _resource_record_pre_action 15:40:42 INFO - Running main action method: run_tests 15:40:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:40:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:40:42 INFO - Python 2.7.3 15:40:42 INFO - Return code: 0 15:40:42 INFO - grabbing minidump binary from tooltool 15:40:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:40:42 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 0x1c51b70>, '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 0x1ca2dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca3250>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:40:42 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 15:40:42 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 15:40:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:40:42 INFO - Return code: 0 15:40:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:40:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:40:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:40:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:40:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:40:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/mwZ-J9TvQv2DFIRp0f6H5g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost'] in /builds/slave/test/build 15:40:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/mwZ-J9TvQv2DFIRp0f6H5g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --webServer localhost 15:40:42 INFO - Using env: {'DISPLAY': ':0', 15:40:42 INFO - 'HOME': '/home/cltbld', 15:40:42 INFO - 'LANG': 'en_US.UTF-8', 15:40:42 INFO - 'LANGUAGE': 'en_US:en', 15:40:42 INFO - 'LOGNAME': 'cltbld', 15:40:42 INFO - 'MAIL': '/var/mail/cltbld', 15:40:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:40:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:40:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:42 INFO - 'MOZ_NO_REMOTE': '1', 15:40:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:40:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:42 INFO - 'NO_EM_RESTART': '1', 15:40:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:42 INFO - 'PWD': '/builds/slave/test', 15:40:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:40:42 INFO - 'SHELL': '/bin/bash', 15:40:42 INFO - 'SHLVL': '1', 15:40:42 INFO - 'TERM': 'linux', 15:40:42 INFO - 'TMOUT': '86400', 15:40:42 INFO - 'USER': 'cltbld', 15:40:42 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1448058753.669034-1042241014', 15:40:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:42 INFO - '_': '/tools/buildbot/bin/python'} 15:40:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/mwZ-J9TvQv2DFIRp0f6H5g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost'] with output_timeout 3600 15:40:42 INFO - mozversion INFO | application_buildid: 20151120142833 15:40:42 INFO - mozversion INFO | application_changeset: 106bfad77bf44d39fc334b336b037a70c2130d52 15:40:42 INFO - mozversion INFO | application_display_name: Nightly 15:40:42 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:40:42 INFO - mozversion INFO | application_name: Firefox 15:40:42 INFO - mozversion INFO | application_remotingname: firefox 15:40:42 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 15:40:42 INFO - mozversion INFO | application_vendor: Mozilla 15:40:42 INFO - mozversion INFO | application_version: 45.0a1 15:40:42 INFO - mozversion INFO | platform_buildid: 20151120142833 15:40:42 INFO - mozversion INFO | platform_changeset: 106bfad77bf44d39fc334b336b037a70c2130d52 15:40:42 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 15:40:42 INFO - mozversion INFO | platform_version: 45.0a1 15:40:42 INFO - 2015-11-20 15:40:42,384 DEBUG : using testdate: 1448062842 15:40:42 INFO - 2015-11-20 15:40:42,384 DEBUG : actual date: 1448062842 15:40:42 INFO - 2015-11-20 15:40:42,480 INFO : starting webserver on 'localhost:59928' 15:40:42 INFO - 2015-11-20 15:40:42,481 INFO : Starting test suite talos-linux64-ix-015 15:40:42 INFO - 2015-11-20 15:40:42,481 INFO : Starting test dromaeo_css 15:40:42 INFO - 2015-11-20 15:40:42,481 DEBUG : operating with platform_type : linux_ 15:40:42 INFO - 2015-11-20 15:40:42,482 INFO : Initialising browser for dromaeo_css test... 15:40:42 INFO - 2015-11-20 15:40:42,493 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI_TUfZ/profile http://localhost:59928/getInfo.html 15:40:46 INFO - 2015-11-20 15:40:46,916 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:40:46 INFO - 2015-11-20 15:40:46,916 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:40:46 INFO - 2015-11-20 15:40:46,916 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 15:40:46 INFO - 2015-11-20 15:40:46,916 DEBUG : BROWSER_OUTPUT: __metrics 15:40:47 INFO - 2015-11-20 15:40:47,039 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:40:48 INFO - 2015-11-20 15:40:48,313 INFO : Browser initialized. 15:40:48 INFO - 2015-11-20 15:40:48,314 INFO : Running cycle 1/1 for dromaeo_css test... 15:40:48 INFO - 2015-11-20 15:40:48,314 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI_TUfZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:41:00 INFO - 2015-11-20 15:41:00,248 DEBUG : BROWSER_OUTPUT: RSS: Main: 141991936 15:41:00 INFO - 2015-11-20 15:41:00,249 DEBUG : BROWSER_OUTPUT: 15:41:51 INFO - 2015-11-20 15:41:51,744 DEBUG : BROWSER_OUTPUT: 1448062911739 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] 15:44:04 INFO - 2015-11-20 15:44:04,036 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59928/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59928/tests/dromaeo/cssquery-ext.html) 15:44:05 INFO - 2015-11-20 15:44:05,112 DEBUG : BROWSER_OUTPUT: RSS: Main: 236986368 15:44:05 INFO - 2015-11-20 15:44:05,113 DEBUG : BROWSER_OUTPUT: 15:47:07 INFO - 2015-11-20 15:47:07,562 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59928/tests/dromaeo/cssquery-ext.html (next: http://localhost:59928/tests/dromaeo/cssquery-jquery.html) 15:47:08 INFO - 2015-11-20 15:47:08,128 DEBUG : BROWSER_OUTPUT: RSS: Main: 213139456 15:47:08 INFO - 2015-11-20 15:47:08,128 DEBUG : BROWSER_OUTPUT: 15:50:10 INFO - 2015-11-20 15:50:10,021 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59928/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59928/tests/dromaeo/cssquery-mootools.html) 15:50:10 INFO - 2015-11-20 15:50:10,594 DEBUG : BROWSER_OUTPUT: RSS: Main: 210624512 15:50:10 INFO - 2015-11-20 15:50:10,594 DEBUG : BROWSER_OUTPUT: 15:53:12 INFO - 2015-11-20 15:53:12,498 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59928/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59928/tests/dromaeo/cssquery-prototype.html) 15:53:13 INFO - 2015-11-20 15:53:13,071 DEBUG : BROWSER_OUTPUT: RSS: Main: 200409088 15:53:13 INFO - 2015-11-20 15:53:13,072 DEBUG : BROWSER_OUTPUT: 15:56:15 INFO - 2015-11-20 15:56:15,800 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59928/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59928/tests/dromaeo/cssquery-yui.html) 15:56:16 INFO - 2015-11-20 15:56:16,386 DEBUG : BROWSER_OUTPUT: RSS: Main: 205152256 15:56:16 INFO - 2015-11-20 15:56:16,386 DEBUG : BROWSER_OUTPUT: 15:59:18 INFO - 2015-11-20 15:59:18,968 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59928/tests/dromaeo/cssquery-yui.html (next: http://localhost:59928/tests/dromaeo/cssquery-dojo.html) 15:59:19 INFO - 2015-11-20 15:59:19,227 DEBUG : BROWSER_OUTPUT: RSS: Main: 247939072 15:59:19 INFO - 2015-11-20 15:59:19,227 DEBUG : BROWSER_OUTPUT: 15:59:19 INFO - 2015-11-20 15:59:19,227 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:59:19 INFO - 2015-11-20 15:59:19,228 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:59:19 INFO - 2015-11-20 15:59:19,228 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:59:19 INFO - 2015-11-20 15:59:19,228 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:59:19 INFO - 2015-11-20 15:59:19,228 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2637.3274814922192;2725.9075965217735;2727.1682136948234;2728.413391120911;2752.7109653486395;4569.154706379314;4681.4382274127065;4817.975910120449;4818.08456393285;4841.080194762997;4715.717056976584;4734.479207287196;4735.668503204777;4853.902921941568;4854.805807767694;4395.736255824653;4412.183746006983;4415.293553031515;4434.711743736663;4435.112977404532;4199.874003779892;4523.819047238107;4527.615152712024;4566;4588.7476188809605;4261.808218630169;4331.805068771912;4334.653227741773;4365.170617582665;4388.517263101056;4362.389265502832;4386.539413361615;4386.605205531518;4405.273129933557;4414.028913638995;4184.456020717318;4297.4413326267695;4363.214621368153;4372.147431250907;4423.491298500681;4519.525449827786;4601.608863246628;4681.157391669498;4692.7653617319;4720.3863497745415;5174.197999310113;5232.215167724834;5238.659487133362;5245.895082098375;5285.709285989269;4890.462049174588;5009.07332143551;5251.133562962106;5254.894902101936;5257.18513630384;4651.372064771246;4696.365990591295;4701.48283688794;4702;4747.240441529408;5340.06548853949;5384.030874442638;5384.273123128406;5384.434634363335;5388.811391601275;4778.235482322812;4902.583280421133;5151.871203219875;5153.896922061538;5190.948090519122;5077.1876499759865;5147.819826306061;5235.554977826851;5256.1327380982475;5294.629375943647;5181.5077567631015;5184;5184.766685499086;5195.896082078413;5239.109351410193;5169.4572069932865;5177.534021937969;5179.249008893689;5180.922286165711;5183.429822719498;4080.5103387593085;4158.293090174678;4200.957990420056;4201.495820501559;4242.575742425733;3782.0922978485514;3782.6028267032116;3800.201957588937;3818;3842.001079719293;4422.270325396338;4434.578715022068;4435.778211089432;4436.955630443719;4475.820967161277;4903.583195428429;4958.553730164231;4966.379202599675;5167.896642067138;5238.580913526985;4225.19721252961;4248.299030659969;4342.370356298319;4452.621527170162;4468.017036252019;4622.029373831533;4627.120847039052;4631.066362652093;4633.49031606523;4677.625789936865;4866.367372241586;4869.853904382874;4871.561559459666;4916.704997700078;4926.039422312686;4941.332920055746;4988.900221995613;5093.108705976365;5098.133317336136;5110.412302585101;4816;4844.297576851266;4848.927266091082;4897;4939.185034469272;5039;5080.618953578571;5094.133997220555;5096.566791822736;5126.4360920297995;4876.756162191805;4994.200927851526;5005.524475174852;5093.949060509348;5154.61340399464;4983.526564976321;4985.351904252424;4987.451380348086;5001.524855138756;5012.974935125301;4967.155583550732;4970.527799859007;4980.975095124501;5005.599552035901;5021.748912554284;4644.256918892961;4760.880977975578;4767.356406885026;4817.662763606514;4928.852134435972;5050.747462626928;5053.393592768891;5055;5072.1123803335;5116;4914.631402644744;4928.753562321941;4929.482404347636;4932.383452068491;4981.676191047571 15:59:19 INFO - 2015-11-20 15:59:19,229 DEBUG : BROWSER_OUTPUT: |1;ext.html;558.1773477157361;574.2391331485783;579.6666916523001;587.1515659871486;595.0122796158378;28642.71357286429;34093.829530852345;34641.30717385654;34667.826660866725;34802.12994675128;40662;41119.383209251886;41355.17289654205;41484.17031659365;41498.58501414985;6973.058637083979;7094.822629434254;7945.721899733496;8077.717279895205;8140.3487720982175;10166.796664066715;10396.896031039669;10419.635312764054;10432.374057556533;10435.843462348033;10120.08919197272;10194;10217.795644087113;10233.692989210298;10235.232357573175;7176.533525320863;7229.674664640103;7294.708211671526;7320.67056982437;10025.147862431702;7022.19244786851;10215.284930054899;10445.529951152217;10453.84319235212;10471.581136754521;37597;38255.42616860749;38411;38418.23163536742;38492;3077.415291094685;3629.491871138043;3633.963660363389;3669.376206044979;3679.7792132472136;28275.717242827515;28645.856770716015;28791.712082879112;29132.27169320784;29182.854085729647;3291.2594666200152;3310.702036816698;3369.0903456066726;3395.813230272334;3397.21863971288;221236;223073;223394;223716;224288;51476.48523514792;52788.472115279124;56587.43412565822;56936.43063569394;57133.42866571281;66780;67317.6634116836;67678.86335344665;67706;67732;13054.738905221842;13280.269585172908;13299.13555618901;13318.267495287851;13352.799708004388;10023.899761002296;10101.19190464761;10124.038216369434;10138.797224055477;10148.035936586013;19050.333238336592;19207.231710731416;19312.80687193138;19480.38360941587;19595.510112247306;7249.202587715347;7623.809404764926;7634.6946122154495;7635.656395462218;7652.196519365387;816.4285000499674;819.6598411659214;885.5527958380976;903.9141281578239;979.0845559401982;26096;26284.21147365582;26302.47395052088;26429.207123786317;26533.33666658349;910.7040211931148;951.8905325887473;961.245422343457;966.9371490853072;1001.9849702254472;14312.713745725026;14905.627359315888;14905.850941490446;15028.549143525712;15182.620434489005;318270;326403;326521;326770;326843;49233.50766492361;49751.50248497541;49770.502294976584;49824.750876246115;49835;1234.493857518413;1235.5799028330412;1254.7866862633375;1256.7926292161874;1257.0948916779903;25833.225003249932;27223;27266.009606263233;27329.310543077227;27639.447211056067;36647.63352366549;37078.8146059268;37114.814425927696;40622;41173;318519;323249;326661;327351;327353;24426.75573244316;24863.751362486142;29888.057276276973;30337.393252134392;30449.391012180076;37734.62265377311;38300.23399531938;38942.80528597339;39781.40327895142;39891.60108398879;29399.805621119962;32697.836510817295;33111.50332744962;33265.66734332722;33748.49377259294;33293.16767080843;33409.665903340654;33599;33620.66379336175;33728.66271337353;33011;33134.33731325312;33329.83335083309;33539.32921341608;33575.49636755402;28403.573946391232;29552.704472954996;30243.546346805255;30274.940377086696;30295.09114726562;23534.882325588263;23589.174378896656;23889.761102388755;23891.283261502183;23975.400614984766 15:59:19 INFO - 2015-11-20 15:59:19,229 DEBUG : BROWSER_OUTPUT: |2;jquery.html;309.5975232198142;317.24337455169416;320.7129618991004;321.77475766963124;327.80004197439575;12785.872141278585;13277.46890124394;15884.682306353867;16332;16421.178941052945;13414.865851341483;13923.860761392383;14317.78523322151;14723.779143312831;14738.336774845131;4333;4935.55579997801;4966.230234313687;5016.673916195436;5098.005888851675;5048.974755126219;5065.924011139836;5089.7964081436885;5090.872728181788;5091.032703786287;5049.394072711261;5050.646454748169;5051.949480505203;5079.695218286896;5244.79020839166;5193.298904647881;5212.687238765686;5213.895722085537;5219.530242278175;5221.503957124086;4986.601071914238;5008.048470790538;5015.32293140425;5022.447530771612;5163.432022477525;11860.703482412922;11869.881301186964;12037;12050.337231452266;17413.825861741472;1773.698471259889;1773.9556511087196;1791.70436877915;1792.5697832520232;1855.3042609021618;9022.233110185642;9787.620546061904;10766;12597.874021259762;12960.675983100404;1577.2744537512758;1583.4853672556465;1659.9336026558924;1688.2824799460302;1736.513776142682;52430.47569524332;55012;55471;55788.72105639446;55844.720776396265;9448.196903263162;9503.384424647826;9513.857292140623;9567.521623918776;9583.664571739955;10358.844617330746;10572.577096916191;11633.88366116328;12076.818847717292;12086.87913120875;6109.541784366191;6205.6586887721605;6279.560430769893;6402.103705481236;6408.391202835724;6010.699465026732;6056.121862329937;6198.287196972406;6220.595661282002;6234.719437625317;4093.3041382964966;4103.4870641169855;4135.58644135584;4146.460960075231;4175.791210439526;1687.907165105931;1692.4668729350215;1732.471596163157;1740.904250266222;1763.8588912886937;844.4173520270994;881.3213825354569;885.818407226517;948.9810203795886;958.6644674364056;15741.921290393475;15914.30681115157;16010.9199454002;16174.27215775293;16243.51269461918;772.424543714936;822.3174764945081;869.1873098652779;926.5969303353063;964.1997142371814;8338.62476188573;8504.596741537576;8663.783405414915;8679.783005424915;8826.293896488265;477759;485176;487527;489446;502723;68575;69282;69563;69883.65058174779;70216;1044.5404022230346;1046.1473898772476;1047.7171163785736;1050.4747626186906;1053.2679787547581;11714.297142171497;13217.537386191438;13372.927196284592;13699.931500342434;13754.105983111065;24836.50326993414;25294.620580690935;30030.849845750632;31377.686223137476;31721.841390793823;36305.461817272844;36857.447138293486;37947.620523795515;38128.04679883025;38258;8571.057183709661;8707.564621769014;8888.33337499703;9059.456432614064;9072.727818165466;10379.584816607252;12594.748105038032;15740;15998.200089995686;16479.83520164783;13253.403596837972;13558.86441135576;13603.79594306106;13887.930560347133;14185.148891066568;12457.563985260473;12518.937405312916;13314.400851961878;13316.866831331563;13323.400446980104;13317.134386264861;13347.733045339233;13455.259960702255;13637.181769093886;13723.382447789674;8307.709230176915;8565.314774818124;8579.742607721779;8619.91380086191;8654.956725216334;12858.807117893051;12923.159994600697;13080.215187088805;13211.735765284448;13358.864496517905 15:59:19 INFO - 2015-11-20 15:59:19,233 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1447.2329665277393;1606.7670187822766;1688.7973443186816;1689.2820551265718;1722.9569260768487;5794.391588883164;6685.264620891704;6847.931520684791;6853.246142924274;6865.485088618361;6674.199096108462;6771.085903403039;6776.390124888759;6778.45772338213;6782.796516104512;1762.5769815244378;1804.4496428589275;2007.1569940624936;2025.9392218233402;2028.9492762680977;2044.2845004248468;2049.5593447408805;2053.58928214357;2055.219016773624;2055.2806517718827;1995.8303544198761;2002.3392280547457;2030.2183659291206;2030.248807941064;2033.7559492860803;1989.4628450318478;2004.5790384019301;2024.7570291565107;2025.625259327022;2032.8272096871783;2024.0891598780609;2040.7653119891254;2043.3869839048225;2046.6009128220003;2047.2015913793632;6911.3779759821355;6979.546329488567;6983.336583024605;6993.47548933832;6994.6152961587095;3949.2299001694396;4009.879703608867;4032.7983600819844;4043.0903046814524;4044.716869819114;2195.078067211775;2572.935676608081;2707.7833773298285;2728.6725592928974;2740.4656092062055;764.7094104240354;831.7274569907989;840.6385254340631;856.498948115347;876.023234093987;9300.627974880997;9396.154346108882;9410.95294523523;9437.24502039842;9442.055794420503;3904.941425878614;3921.6078392160557;3988.940165897514;4005.7997100144876;4017.799110044486;8058.597070146469;8062;8062.7581172564915;8065.919340806634;8076.515409075474;4055.533613634411;4089.672826173899;4093.2018256440306;4110.219058378899;4119.299719047769;3667.9083022924106;3691.483192353019;3694.0210844126327;3694.168812017275;3698.056995466193;3411.488276758506;3424.07549961514;3424.503447000171;3438.1920248741526;3443.380191565542;993.8608594796734;1004.1715584642699;1014.2950649298814;1026.4252018869456;1032.829583118792;1182.798924182891;1183.6094088950626;1186.9169158159018;1202.5911190195375;1203.1096988228649;6467.450266727381;6496.837579060561;6530.836729081716;6545.050967609765;6562.081308616797;396.71634781131627;397.7911596411849;398.27911480220894;399.21354930786305;404.7005216140035;5237.319148510745;5329.813456529003;5330.360356757214;5331.493508116722;5333.839984800462;8136.55248961301;8253.174682531699;8436.493810371398;8464.238218560358;8472.364572657076;8351;8359.205875441823;8405.663773448994;8412.537310447862;8422.199891010345;6290.308066112724;6555.049517819984;6655.767048153291;6657.400833924873;6663.733450661919;6262.68686565679;6474.708638111202;6513.3161018094315;6539.901901471387;6588.8352791180605;7449.515781474187;7488.775336739906;7490.588017659081;7500;7516.060492438445;7557.697692092254;7597.050368703912;7700.075990881131;7776.961115194388;7797.064352277763;6682.064510968566;6764.425023873026;6768.187817461936;6772.390484856386;6775.966120169368;6591.472682185509;6726.932730672631;6739.427148692416;6765.323467653196;6788.558743681645;6207.255129384503;6267;6342.080398342307;6350.301466838737;6433.067205255305;6258.687065646791;6337.302896681269;6348.460380867678;6361.045843123568;6432.2281326241155;6211.099390588249;6277.246730392382;6337.112804207507;6347.143135676624;6347.39699728525;6004.489618382487;6058.5758996871555;6068.211132552917;6073.5748497604745;6076.665783381956;5970.0746384310505;6023.759049637965;6028.819135425944;6064.545159113172;6069.544784141295 15:59:19 INFO - 2015-11-20 15:59:19,234 DEBUG : BROWSER_OUTPUT: |4;prototype.html;293.95149800282957;300.75187969924804;302.17807563427476;305.62255614316314;308.12646148169944;5407;5498.010358135534;5512.641678290918;5516.668999860011;5533.833984980457;5160.974195129019;5248.501392367729;5316.494932981361;5388.326459192601;5410.053240682884;4235.682323825726;4240.893977650568;4244.4906611206625;4247.235497610429;4256.659467242614;4005.679545636342;4227.978860105711;4238.919075635708;4240.830366785325;4243.511996120439;4058.5738497457783;4060.2691515527194;4162.209180255742;4164.27125253081;4208.747475151501;4152;4202.411662367271;4205.915881682365;4213.389058586487;4214.241436541437;3699.26014797039;3701.1117331840433;3702.8148592570265;3704.7221458390727;3708.072981754561;5173.275741396207;5222.973885130588;5224.164133738584;5228.320318358627;5230.476952304777;4648.907021859543;4775.355327030841;4806.182948898696;4811.663183577151;4875.219964805649;5713.085906255021;5719.6854173020465;5728.742206600713;5729.541636669098;5733.627314224562;3941.5664276929515;3944.191440754667;3946.4869566956113;3947.032976920644;3947.7631342119566;5936.673482958436;6012.278526576839;6014.609050411709;6027.547933904974;6028.367021462727;3930.5653436495472;4055.1078762672164;4061.614146656063;4065.593440655911;4070.043539768152;4100.077482566398;4101.7744024078365;4119.402686610425;4119.588041195856;4124.154548317588;4762.618990480753;4774.069056533943;4776.450708168605;4776.47458779534;4784.569388755029;5775.27809023872;5776.942230577724;5781.595288329777;5785.768569257182;5787.652740835563;1410.2948525737131;1427.5717284814514;1454.7163303155783;1454.992725036368;1459.9343029563695;959.5346257065318;961.0917682789836;973.776031512756;985.1232403161192;985.8324084905584;4899.363082799285;4939.925901111486;4970.975145124251;4978.32792572998;4981.128302547112;5888.705564721747;5899.646021238739;5899.646021238739;5902.61632993854;5906.114082887601;4879.170541008037;4886.853394398174;4941.703497790144;4991.4758950310425;5004.749762511859;3208.2300247940793;3222.113918672384;3239.6436391996863;3239.7408207343356;3244.0592228254013;5609.074502707089;5632.436756324417;5634.746436410372;5640;5643.673736671879;6041.154238406627;6128.3258841527395;6158.476529495043;6160.075988601746;6173.536984726074;5634.802781902614;5634.943650563442;5639.097744360883;5640.661560306395;5642.576806739511;6001.549883758648;6005.219321488178;6008.5493587981955;6013.789517366871;6017.518598512021;5804.622699524517;5838.708064596668;5839.036558967723;5857.560682948882;5869.413058694096;5475.72621368922;5587.525060369914;5610.214569960291;5626.409227031103;5630.352509461464;4058.0869304406274;4058.2695114878425;4058.330375488011;4059.6143366380147;4060.614241647039;5979.611325263844;5982.551308651781;5991.3409524953095;5993.280806303272;6002.579819412599;5633.267675202362;5748.626339287933;5758.395368486249;5769.0481070624555;5775.537956963349;5766.94233057664;5767.826965191051;5780.421957804186;5783.814318064702;5784.248047753933;5636.239107720406;5636.943630563642;5644.8306550803545;5648.745806438802;5660.773569057192;5695;5781.161731548986;5826.82519524415;5831;5832.650040997553;5649.067903795828;5651.886962260814;5653.915191272216;5661.065924122474;5661.971690141688 15:59:19 INFO - 2015-11-20 15:59:19,234 DEBUG : BROWSER_OUTPUT: |5;yui.html;788.6017561131631;791.295746785361;795.2365728900259;802.2058162419205;811.8944537210161;11182.66452006439;11387.089032877371;11389.08887289017;11390.487428065737;11412.54349826006;11847.111466640015;11943.462544185511;11958.820617690742;11958.880411195907;11969.880301196985;608.2245137449743;624.9218847644045;624.9750009999594;777.3509119884903;802.7993001749562;798.7284323330067;800.7437619961614;805.7059173401695;805.87508936115;805.9677612895478;832.937529685273;839.0351096239343;839.0812060793421;840.6595328891779;840.8108175660489;630.9526785491083;640.8910485217524;811.4928169893816;822.6956026270259;825.8843761873343;614.3733391940241;616.9568130230886;617.5461036138435;617.8609812792131;618.1068356225256;11045.83431248532;11147.832782508269;11167.664970050912;11185.161112916563;11196.776064478747;10917.945410272898;11441.599544015919;11491.42542872853;11884.405779711067;11937.522499100025;8850.291976641918;8863.645454181826;8951.23914467271;9020.864687029634;9037.593308301077;3222.065600975714;3224.774265801395;3250.414925313443;3279.5572597699243;3313.055779102944;39857.40213896765;40029.39955900664;40066.19867602661;40136.59863401387;40283.395749063784;8769.342299327576;8914.509701966454;8960.462372257685;9038.231750301167;9039.728808135766;15216.391344346102;15259.313330900137;15262.236888155549;15263;15276.618084547754;6222.81331560054;6249.96875015622;6339.239291284983;6431.871362572816;6465.094886715863;3476.66971637694;3582.3372676055014;3611.133328001261;3642.581103173116;3702.129999450127;2535.3915060385375;2567.0373609896287;2576.716561178269;2582.2382397192873;2583.4962182374634;468.7703025517472;473.98815029624535;474.79821076042543;485.30601240226815;489.3662706794638;459.37754342864935;483.7943873853598;567.9943200568024;570.4409678514995;581.102197105473;7161.4279109768295;7273.927260727325;7293.8905916411295;7303.780886573411;7327.74352897646;484.05125953132256;570.8258981010831;602.5270162922085;605.5488660947534;617.7776000639766;3558.928821423557;3603.612599164214;3644.4168932970597;3708.925821483609;3710.5732840723663;54892.45107548953;55331.44668553343;55381.446185538436;55515.44484555103;55552;46708.766456167505;47019.5298047022;47434.76282618565;47486;47551;42269.36595951063;42546.36180457295;42796.572034279256;43434;43441.34837977433;7115.82210444743;7267.382272506896;7286.96356518214;7412.555246685216;7892.329152021913;31167.376652467276;31384;32062.198445038128;32184.83907580447;32377;40686.79656601698;40877.79561102176;40940;41335.1732965345;41798.791006044776;9941.900580994097;10006.09945104944;10143.137833283958;10180.949095254477;10208.476654802236;11133.435291530433;11251.324920504796;11325.660230193107;11361.886381136082;11723.41382930867;10375.740606484898;10394.74013149647;10402.271840971362;10438.895611043792;10468.162546996375;10312.432816195182;10407.635732749317;10587.947060264649;10589.841152382567;10652.041316281262;10255.384676919408;10420.270581059252;10536.78926421452;10673.839892401465;10839.891601083888;9038.819223615623;9141.725748227564;9328.766780830534;9465.810683786423;9471.10024547667;8655.48067115975;8733.519656418957;8900.73297801067;8932.374733768575;8980.86528702083 15:59:19 INFO - 2015-11-20 15:59:19,234 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:59:19 INFO - 2015-11-20 15:59:19,234 DEBUG : BROWSER_OUTPUT: __start_cc_report 15:59:19 INFO - 2015-11-20 15:59:19,234 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,853 15:59:19 INFO - 2015-11-20 15:59:19,234 DEBUG : BROWSER_OUTPUT: __end_cc_report 15:59:19 INFO - 2015-11-20 15:59:19,234 DEBUG : BROWSER_OUTPUT: __startTimestamp1448063959221__endTimestamp 15:59:19 INFO - 2015-11-20 15:59:19,234 DEBUG : BROWSER_OUTPUT: 15:59:19 INFO - 2015-11-20 15:59:19,235 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:59:19 INFO - 2015-11-20 15:59:19,235 DEBUG : BROWSER_OUTPUT: Number of tests: 6 15:59:19 INFO - 2015-11-20 15:59:19,235 DEBUG : BROWSER_OUTPUT: 15:59:19 INFO - 2015-11-20 15:59:19,235 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4728.53 Median:4854.81 stddev:510.96 (10.5%) stddev-sans-first:485.48 15:59:19 INFO - 2015-11-20 15:59:19,235 DEBUG : BROWSER_OUTPUT: Values: 2637.3 2725.9 2727.2 2728.4 2752.7 4569.2 4681.4 4818.0 4818.1 4841.1 4715.7 4734.5 4735.7 4853.9 4854.8 4395.7 4412.2 4415.3 4434.7 4435.1 4199.9 4523.8 4527.6 4566.0 4588.7 4261.8 4331.8 4334.7 4365.2 4388.5 4362.4 4386.5 4386.6 4405.3 4414.0 4184.5 4297.4 4363.2 4372.1 4423.5 4519.5 4601.6 4681.2 4692.8 4720.4 5174.2 5232.2 5238.7 5245.9 5285.7 4890.5 5009.1 5251.1 5254.9 5257.2 4651.4 4696.4 4701.5 4702.0 4747.2 5340.1 5384.0 5384.3 5384.4 5388.8 4778.2 4902.6 5151.9 5153.9 5190.9 5077.2 5147.8 5235.6 5256.1 5294.6 5181.5 5184.0 5184.8 5195.9 5239.1 5169.5 5177.5 5179.2 5180.9 5183.4 4080.5 4158.3 4201.0 4201.5 4242.6 3782.1 3782.6 3800.2 3818.0 3842.0 4422.3 4434.6 4435.8 4437.0 4475.8 4903.6 4958.6 4966.4 5167.9 5238.6 4225.2 4248.3 4342.4 4452.6 4468.0 4622.0 4627.1 4631.1 4633.5 4677.6 4866.4 4869.9 4871.6 4916.7 4926.0 4941.3 4988.9 5093.1 5098.1 5110.4 4816.0 4844.3 4848.9 4897.0 4939.2 5039.0 5080.6 5094.1 5096.6 5126.4 4876.8 4994.2 5005.5 5093.9 5154.6 4983.5 4985.4 4987.5 5001.5 5013.0 4967.2 4970.5 4981.0 5005.6 5021.7 4644.3 4760.9 4767.4 4817.7 4928.9 5050.7 5053.4 5055.0 5072.1 5116.0 4914.6 4928.8 4929.5 4932.4 4981.7 15:59:19 INFO - 2015-11-20 15:59:19,235 DEBUG : BROWSER_OUTPUT: 15:59:19 INFO - 2015-11-20 15:59:19,235 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:44987.85 Median:18151.13 stddev:77395.19 (426.4%) stddev-sans-first:77540.41 15:59:19 INFO - 2015-11-20 15:59:19,236 DEBUG : BROWSER_OUTPUT: Values: 558.2 574.2 579.7 587.2 595.0 28642.7 34093.8 34641.3 34667.8 34802.1 40662.0 41119.4 41355.2 41484.2 41498.6 6973.1 7094.8 7945.7 8077.7 8140.3 10166.8 10396.9 10419.6 10432.4 10435.8 10120.1 10194.0 10217.8 10233.7 10235.2 7176.5 7229.7 7294.7 7320.7 10025.1 7022.2 10215.3 10445.5 10453.8 10471.6 37597.0 38255.4 38411.0 38418.2 38492.0 3077.4 3629.5 3634.0 3669.4 3679.8 28275.7 28645.9 28791.7 29132.3 29182.9 3291.3 3310.7 3369.1 3395.8 3397.2 221236.0 223073.0 223394.0 223716.0 224288.0 51476.5 52788.5 56587.4 56936.4 57133.4 66780.0 67317.7 67678.9 67706.0 67732.0 13054.7 13280.3 13299.1 13318.3 13352.8 10023.9 10101.2 10124.0 10138.8 10148.0 19050.3 19207.2 19312.8 19480.4 19595.5 7249.2 7623.8 7634.7 7635.7 7652.2 816.4 819.7 885.6 903.9 979.1 26096.0 26284.2 26302.5 26429.2 26533.3 910.7 951.9 961.2 966.9 1002.0 14312.7 14905.6 14905.9 15028.5 15182.6 318270.0 326403.0 326521.0 326770.0 326843.0 49233.5 49751.5 49770.5 49824.8 49835.0 1234.5 1235.6 1254.8 1256.8 1257.1 25833.2 27223.0 27266.0 27329.3 27639.4 36647.6 37078.8 37114.8 40622.0 41173.0 318519.0 323249.0 326661.0 327351.0 327353.0 24426.8 24863.8 29888.1 30337.4 30449.4 37734.6 38300.2 38942.8 39781.4 39891.6 29399.8 32697.8 33111.5 33265.7 33748.5 33293.2 33409.7 33599.0 33620.7 33728.7 33011.0 33134.3 33329.8 33539.3 33575.5 28403.6 29552.7 30243.5 30274.9 30295.1 23534.9 23589.2 23889.8 23891.3 23975.4 15:59:19 INFO - 2015-11-20 15:59:19,236 DEBUG : BROWSER_OUTPUT: 15:59:19 INFO - 2015-11-20 15:59:19,236 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25723.39 Median:38037.83 stddev:79759.20 (209.7%) stddev-sans-first:79960.12 15:59:19 INFO - 2015-11-20 15:59:19,237 DEBUG : BROWSER_OUTPUT: Values: 309.6 317.2 320.7 321.8 327.8 12785.9 13277.5 15884.7 16332.0 16421.2 13414.9 13923.9 14317.8 14723.8 14738.3 4333.0 4935.6 4966.2 5016.7 5098.0 5049.0 5065.9 5089.8 5090.9 5091.0 5049.4 5050.6 5051.9 5079.7 5244.8 5193.3 5212.7 5213.9 5219.5 5221.5 4986.6 5008.0 5015.3 5022.4 5163.4 11860.7 11869.9 12037.0 12050.3 17413.8 1773.7 1774.0 1791.7 1792.6 1855.3 9022.2 9787.6 10766.0 12597.9 12960.7 1577.3 1583.5 1659.9 1688.3 1736.5 52430.5 55012.0 55471.0 55788.7 55844.7 9448.2 9503.4 9513.9 9567.5 9583.7 10358.8 10572.6 11633.9 12076.8 12086.9 6109.5 6205.7 6279.6 6402.1 6408.4 6010.7 6056.1 6198.3 6220.6 6234.7 4093.3 4103.5 4135.6 4146.5 4175.8 1687.9 1692.5 1732.5 1740.9 1763.9 844.4 881.3 885.8 949.0 958.7 15741.9 15914.3 16010.9 16174.3 16243.5 772.4 822.3 869.2 926.6 964.2 8338.6 8504.6 8663.8 8679.8 8826.3 477759.0 485176.0 487527.0 489446.0 502723.0 68575.0 69282.0 69563.0 69883.7 70216.0 1044.5 1046.1 1047.7 1050.5 1053.3 11714.3 13217.5 13372.9 13699.9 13754.1 24836.5 25294.6 30030.8 31377.7 31721.8 36305.5 36857.4 37947.6 38128.0 38258.0 8571.1 8707.6 8888.3 9059.5 9072.7 10379.6 12594.7 15740.0 15998.2 16479.8 13253.4 13558.9 13603.8 13887.9 14185.1 12457.6 12518.9 13314.4 13316.9 13323.4 13317.1 13347.7 13455.3 13637.2 13723.4 8307.7 8565.3 8579.7 8619.9 8655.0 12858.8 12923.2 13080.2 13211.7 13358.9 15:59:19 INFO - 2015-11-20 15:59:19,237 DEBUG : BROWSER_OUTPUT: 15:59:19 INFO - 2015-11-20 15:59:19,237 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4889.77 Median:6209.18 stddev:2549.31 (41.1%) stddev-sans-first:2543.33 15:59:19 INFO - 2015-11-20 15:59:19,237 DEBUG : BROWSER_OUTPUT: Values: 1447.2 1606.8 1688.8 1689.3 1723.0 5794.4 6685.3 6847.9 6853.2 6865.5 6674.2 6771.1 6776.4 6778.5 6782.8 1762.6 1804.4 2007.2 2025.9 2028.9 2044.3 2049.6 2053.6 2055.2 2055.3 1995.8 2002.3 2030.2 2030.2 2033.8 1989.5 2004.6 2024.8 2025.6 2032.8 2024.1 2040.8 2043.4 2046.6 2047.2 6911.4 6979.5 6983.3 6993.5 6994.6 3949.2 4009.9 4032.8 4043.1 4044.7 2195.1 2572.9 2707.8 2728.7 2740.5 764.7 831.7 840.6 856.5 876.0 9300.6 9396.2 9411.0 9437.2 9442.1 3904.9 3921.6 3988.9 4005.8 4017.8 8058.6 8062.0 8062.8 8065.9 8076.5 4055.5 4089.7 4093.2 4110.2 4119.3 3667.9 3691.5 3694.0 3694.2 3698.1 3411.5 3424.1 3424.5 3438.2 3443.4 993.9 1004.2 1014.3 1026.4 1032.8 1182.8 1183.6 1186.9 1202.6 1203.1 6467.5 6496.8 6530.8 6545.1 6562.1 396.7 397.8 398.3 399.2 404.7 5237.3 5329.8 5330.4 5331.5 5333.8 8136.6 8253.2 8436.5 8464.2 8472.4 8351.0 8359.2 8405.7 8412.5 8422.2 6290.3 6555.0 6655.8 6657.4 6663.7 6262.7 6474.7 6513.3 6539.9 6588.8 7449.5 7488.8 7490.6 7500.0 7516.1 7557.7 7597.1 7700.1 7777.0 7797.1 6682.1 6764.4 6768.2 6772.4 6776.0 6591.5 6726.9 6739.4 6765.3 6788.6 6207.3 6267.0 6342.1 6350.3 6433.1 6258.7 6337.3 6348.5 6361.0 6432.2 6211.1 6277.2 6337.1 6347.1 6347.4 6004.5 6058.6 6068.2 6073.6 6076.7 5970.1 6023.8 6028.8 6064.5 6069.5 15:59:19 INFO - 2015-11-20 15:59:19,237 DEBUG : BROWSER_OUTPUT: 15:59:19 INFO - 2015-11-20 15:59:19,237 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4746.79 Median:5442.89 stddev:1408.67 (25.9%) stddev-sans-first:1372.40 15:59:19 INFO - 2015-11-20 15:59:19,238 DEBUG : BROWSER_OUTPUT: Values: 294.0 300.8 302.2 305.6 308.1 5407.0 5498.0 5512.6 5516.7 5533.8 5161.0 5248.5 5316.5 5388.3 5410.1 4235.7 4240.9 4244.5 4247.2 4256.7 4005.7 4228.0 4238.9 4240.8 4243.5 4058.6 4060.3 4162.2 4164.3 4208.7 4152.0 4202.4 4205.9 4213.4 4214.2 3699.3 3701.1 3702.8 3704.7 3708.1 5173.3 5223.0 5224.2 5228.3 5230.5 4648.9 4775.4 4806.2 4811.7 4875.2 5713.1 5719.7 5728.7 5729.5 5733.6 3941.6 3944.2 3946.5 3947.0 3947.8 5936.7 6012.3 6014.6 6027.5 6028.4 3930.6 4055.1 4061.6 4065.6 4070.0 4100.1 4101.8 4119.4 4119.6 4124.2 4762.6 4774.1 4776.5 4776.5 4784.6 5775.3 5776.9 5781.6 5785.8 5787.7 1410.3 1427.6 1454.7 1455.0 1459.9 959.5 961.1 973.8 985.1 985.8 4899.4 4939.9 4971.0 4978.3 4981.1 5888.7 5899.6 5899.6 5902.6 5906.1 4879.2 4886.9 4941.7 4991.5 5004.7 3208.2 3222.1 3239.6 3239.7 3244.1 5609.1 5632.4 5634.7 5640.0 5643.7 6041.2 6128.3 6158.5 6160.1 6173.5 5634.8 5634.9 5639.1 5640.7 5642.6 6001.5 6005.2 6008.5 6013.8 6017.5 5804.6 5838.7 5839.0 5857.6 5869.4 5475.7 5587.5 5610.2 5626.4 5630.4 4058.1 4058.3 4058.3 4059.6 4060.6 5979.6 5982.6 5991.3 5993.3 6002.6 5633.3 5748.6 5758.4 5769.0 5775.5 5766.9 5767.8 5780.4 5783.8 5784.2 5636.2 5636.9 5644.8 5648.7 5660.8 5695.0 5781.2 5826.8 5831.0 5832.7 5649.1 5651.9 5653.9 5661.1 5662.0 15:59:19 INFO - 2015-11-20 15:59:19,238 DEBUG : BROWSER_OUTPUT: 15:59:19 INFO - 2015-11-20 15:59:19,239 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12467.88 Median:23588.77 stddev:14658.34 (62.1%) stddev-sans-first:14673.22 15:59:19 INFO - 2015-11-20 15:59:19,240 DEBUG : BROWSER_OUTPUT: Values: 788.6 791.3 795.2 802.2 811.9 11182.7 11387.1 11389.1 11390.5 11412.5 11847.1 11943.5 11958.8 11958.9 11969.9 608.2 624.9 625.0 777.4 802.8 798.7 800.7 805.7 805.9 806.0 832.9 839.0 839.1 840.7 840.8 631.0 640.9 811.5 822.7 825.9 614.4 617.0 617.5 617.9 618.1 11045.8 11147.8 11167.7 11185.2 11196.8 10917.9 11441.6 11491.4 11884.4 11937.5 8850.3 8863.6 8951.2 9020.9 9037.6 3222.1 3224.8 3250.4 3279.6 3313.1 39857.4 40029.4 40066.2 40136.6 40283.4 8769.3 8914.5 8960.5 9038.2 9039.7 15216.4 15259.3 15262.2 15263.0 15276.6 6222.8 6250.0 6339.2 6431.9 6465.1 3476.7 3582.3 3611.1 3642.6 3702.1 2535.4 2567.0 2576.7 2582.2 2583.5 468.8 474.0 474.8 485.3 489.4 459.4 483.8 568.0 570.4 581.1 7161.4 7273.9 7293.9 7303.8 7327.7 484.1 570.8 602.5 605.5 617.8 3558.9 3603.6 3644.4 3708.9 3710.6 54892.5 55331.4 55381.4 55515.4 55552.0 46708.8 47019.5 47434.8 47486.0 47551.0 42269.4 42546.4 42796.6 43434.0 43441.3 7115.8 7267.4 7287.0 7412.6 7892.3 31167.4 31384.0 32062.2 32184.8 32377.0 40686.8 40877.8 40940.0 41335.2 41798.8 9941.9 10006.1 10143.1 10180.9 10208.5 11133.4 11251.3 11325.7 11361.9 11723.4 10375.7 10394.7 10402.3 10438.9 10468.2 10312.4 10407.6 10587.9 10589.8 10652.0 10255.4 10420.3 10536.8 10673.8 10839.9 9038.8 9141.7 9328.8 9465.8 9471.1 8655.5 8733.5 8900.7 8932.4 8980.9 15:59:19 INFO - 2015-11-20 15:59:19,240 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:59:19 INFO - 2015-11-20 15:59:19,240 DEBUG : BROWSER_OUTPUT: 15:59:19 INFO - 2015-11-20 15:59:19,949 INFO : Browser exited with error code: 0 15:59:19 INFO - 2015-11-20 15:59:19,970 INFO : Completed test dromaeo_css (00:18:37) 15:59:19 INFO - 2015-11-20 15:59:19,970 INFO : Starting test kraken 15:59:19 INFO - 2015-11-20 15:59:19,971 DEBUG : operating with platform_type : linux_ 15:59:19 INFO - 2015-11-20 15:59:19,971 INFO : Initialising browser for kraken test... 15:59:19 INFO - 2015-11-20 15:59:19,977 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQOFnYd/profile http://localhost:59928/getInfo.html 15:59:24 INFO - 2015-11-20 15:59:24,098 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:59:24 INFO - 2015-11-20 15:59:24,098 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:59:24 INFO - 2015-11-20 15:59:24,098 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 15:59:24 INFO - 2015-11-20 15:59:24,098 DEBUG : BROWSER_OUTPUT: __metrics 15:59:24 INFO - 2015-11-20 15:59:24,215 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:59:25 INFO - 2015-11-20 15:59:25,647 INFO : Browser initialized. 15:59:25 INFO - 2015-11-20 15:59:25,647 INFO : Running cycle 1/1 for kraken test... 15:59:25 INFO - 2015-11-20 15:59:25,648 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQOFnYd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:59:37 INFO - 2015-11-20 15:59:37,624 DEBUG : BROWSER_OUTPUT: RSS: Main: 141692928 15:59:37 INFO - 2015-11-20 15:59:37,624 DEBUG : BROWSER_OUTPUT: 15:59:40 INFO - 2015-11-20 15:59:40,265 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59928/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59928/tests/kraken/driver.html?testName=audio-beat-detection) 15:59:40 INFO - 2015-11-20 15:59:40,850 DEBUG : BROWSER_OUTPUT: RSS: Main: 175124480 15:59:40 INFO - 2015-11-20 15:59:40,851 DEBUG : BROWSER_OUTPUT: 15:59:43 INFO - 2015-11-20 15:59:43,579 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59928/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59928/tests/kraken/driver.html?testName=audio-dft) 15:59:44 INFO - 2015-11-20 15:59:44,160 DEBUG : BROWSER_OUTPUT: RSS: Main: 165908480 15:59:44 INFO - 2015-11-20 15:59:44,161 DEBUG : BROWSER_OUTPUT: 15:59:47 INFO - 2015-11-20 15:59:47,164 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59928/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59928/tests/kraken/driver.html?testName=audio-fft) 15:59:47 INFO - 2015-11-20 15:59:47,737 DEBUG : BROWSER_OUTPUT: RSS: Main: 152895488 15:59:47 INFO - 2015-11-20 15:59:47,738 DEBUG : BROWSER_OUTPUT: 15:59:49 INFO - 2015-11-20 15:59:49,779 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59928/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59928/tests/kraken/driver.html?testName=audio-oscillator) 15:59:50 INFO - 2015-11-20 15:59:50,347 DEBUG : BROWSER_OUTPUT: RSS: Main: 154353664 15:59:50 INFO - 2015-11-20 15:59:50,347 DEBUG : BROWSER_OUTPUT: 15:59:52 INFO - 2015-11-20 15:59:52,602 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59928/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59928/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:59:53 INFO - 2015-11-20 15:59:53,163 DEBUG : BROWSER_OUTPUT: RSS: Main: 155328512 15:59:53 INFO - 2015-11-20 15:59:53,163 DEBUG : BROWSER_OUTPUT: 15:59:56 INFO - 2015-11-20 15:59:56,134 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59928/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59928/tests/kraken/driver.html?testName=imaging-darkroom) 15:59:56 INFO - 2015-11-20 15:59:56,715 DEBUG : BROWSER_OUTPUT: RSS: Main: 156839936 15:59:56 INFO - 2015-11-20 15:59:56,715 DEBUG : BROWSER_OUTPUT: 16:00:00 INFO - 2015-11-20 16:00:00,068 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59928/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59928/tests/kraken/driver.html?testName=imaging-desaturate) 16:00:00 INFO - 2015-11-20 16:00:00,641 DEBUG : BROWSER_OUTPUT: RSS: Main: 157868032 16:00:00 INFO - 2015-11-20 16:00:00,641 DEBUG : BROWSER_OUTPUT: 16:00:03 INFO - 2015-11-20 16:00:03,430 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59928/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59928/tests/kraken/driver.html?testName=json-parse-financial) 16:00:04 INFO - 2015-11-20 16:00:04,012 DEBUG : BROWSER_OUTPUT: RSS: Main: 157233152 16:00:04 INFO - 2015-11-20 16:00:04,012 DEBUG : BROWSER_OUTPUT: 16:00:05 INFO - 2015-11-20 16:00:05,768 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59928/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59928/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:00:06 INFO - 2015-11-20 16:00:06,336 DEBUG : BROWSER_OUTPUT: RSS: Main: 163803136 16:00:06 INFO - 2015-11-20 16:00:06,336 DEBUG : BROWSER_OUTPUT: 16:00:08 INFO - 2015-11-20 16:00:08,226 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59928/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59928/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:00:08 INFO - 2015-11-20 16:00:08,827 DEBUG : BROWSER_OUTPUT: RSS: Main: 162938880 16:00:08 INFO - 2015-11-20 16:00:08,827 DEBUG : BROWSER_OUTPUT: 16:00:10 INFO - 2015-11-20 16:00:10,965 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59928/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59928/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:00:11 INFO - 2015-11-20 16:00:11,538 DEBUG : BROWSER_OUTPUT: RSS: Main: 172142592 16:00:11 INFO - 2015-11-20 16:00:11,538 DEBUG : BROWSER_OUTPUT: 16:00:14 INFO - 2015-11-20 16:00:14,073 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59928/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59928/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:00:14 INFO - 2015-11-20 16:00:14,656 DEBUG : BROWSER_OUTPUT: RSS: Main: 178376704 16:00:14 INFO - 2015-11-20 16:00:14,656 DEBUG : BROWSER_OUTPUT: 16:00:17 INFO - 2015-11-20 16:00:17,218 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59928/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59928/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:00:17 INFO - 2015-11-20 16:00:17,799 DEBUG : BROWSER_OUTPUT: RSS: Main: 175947776 16:00:17 INFO - 2015-11-20 16:00:17,800 DEBUG : BROWSER_OUTPUT: 16:00:19 INFO - 2015-11-20 16:00:19,535 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59928/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59928/tests/kraken/driver.html?testName=ai-astar) 16:00:19 INFO - 2015-11-20 16:00:19,793 DEBUG : BROWSER_OUTPUT: RSS: Main: 235163648 16:00:19 INFO - 2015-11-20 16:00:19,793 DEBUG : BROWSER_OUTPUT: 16:00:19 INFO - 2015-11-20 16:00:19,793 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:00:19 INFO - 2015-11-20 16:00:19,794 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:00:19 INFO - 2015-11-20 16:00:19,794 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:00:19 INFO - 2015-11-20 16:00:19,794 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:00:19 INFO - 2015-11-20 16:00:19,794 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;112;105;110;110;112;101;112;104;111 16:00:19 INFO - 2015-11-20 16:00:19,795 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;157;130;150;174;140;153;155;141;171;130 16:00:19 INFO - 2015-11-20 16:00:19,795 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;162;162;163;161;160;161;163;162;160 16:00:19 INFO - 2015-11-20 16:00:19,795 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;81;84;94;71;72;75;104;91;73 16:00:19 INFO - 2015-11-20 16:00:19,795 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;92;127;91;92;93;126;91;91;128 16:00:19 INFO - 2015-11-20 16:00:19,795 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;110;109;109;109;110;109;109 16:00:19 INFO - 2015-11-20 16:00:19,796 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;151;146;146;146;147;146;147;146;147 16:00:19 INFO - 2015-11-20 16:00:19,796 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;94;95;96;95;95;96;96;95;95;95 16:00:19 INFO - 2015-11-20 16:00:19,796 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;71;71;72;70;71;72;71;79;70;69 16:00:19 INFO - 2015-11-20 16:00:19,796 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;69;68;69;68;69;73;68;68 16:00:19 INFO - 2015-11-20 16:00:19,797 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;85;83;83;84;83;85;86;86;87 16:00:19 INFO - 2015-11-20 16:00:19,797 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;120;120;122;120;127;128;120;127;129;131 16:00:19 INFO - 2015-11-20 16:00:19,797 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;147;134;141;137;143;138;148;151;159;135 16:00:19 INFO - 2015-11-20 16:00:19,797 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;70;70;71;69;71;70;68;68;67 16:00:19 INFO - 2015-11-20 16:00:19,797 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:00:19 INFO - 2015-11-20 16:00:19,797 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:00:19 INFO - 2015-11-20 16:00:19,798 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,968 16:00:19 INFO - 2015-11-20 16:00:19,798 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:00:19 INFO - 2015-11-20 16:00:19,798 DEBUG : BROWSER_OUTPUT: __startTimestamp1448064019788__endTimestamp 16:00:19 INFO - 2015-11-20 16:00:19,798 DEBUG : BROWSER_OUTPUT: 16:00:19 INFO - 2015-11-20 16:00:19,798 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:00:19 INFO - 2015-11-20 16:00:19,798 DEBUG : BROWSER_OUTPUT: Number of tests: 14 16:00:19 INFO - 2015-11-20 16:00:19,798 DEBUG : BROWSER_OUTPUT: 16:00:19 INFO - 2015-11-20 16:00:19,799 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.70 Median:110.50 stddev:3.92 (3.5%) stddev-sans-first:4.13 16:00:19 INFO - 2015-11-20 16:00:19,799 DEBUG : BROWSER_OUTPUT: Values: 110.0 112.0 105.0 110.0 110.0 112.0 101.0 112.0 104.0 111.0 16:00:19 INFO - 2015-11-20 16:00:19,799 DEBUG : BROWSER_OUTPUT: 16:00:19 INFO - 2015-11-20 16:00:19,799 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.10 Median:154.00 stddev:15.21 (9.9%) stddev-sans-first:15.92 16:00:19 INFO - 2015-11-20 16:00:19,799 DEBUG : BROWSER_OUTPUT: Values: 157.0 130.0 150.0 174.0 140.0 153.0 155.0 141.0 171.0 130.0 16:00:19 INFO - 2015-11-20 16:00:19,799 DEBUG : BROWSER_OUTPUT: 16:00:19 INFO - 2015-11-20 16:00:19,800 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.07 (0.7%) stddev-sans-first:1.13 16:00:19 INFO - 2015-11-20 16:00:19,800 DEBUG : BROWSER_OUTPUT: Values: 162.0 162.0 162.0 163.0 161.0 160.0 161.0 163.0 162.0 160.0 16:00:19 INFO - 2015-11-20 16:00:19,801 DEBUG : BROWSER_OUTPUT: 16:00:19 INFO - 2015-11-20 16:00:19,801 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.70 Median:78.00 stddev:11.37 (14.6%) stddev-sans-first:11.51 16:00:19 INFO - 2015-11-20 16:00:19,801 DEBUG : BROWSER_OUTPUT: Values: 72.0 81.0 84.0 94.0 71.0 72.0 75.0 104.0 91.0 73.0 16:00:19 INFO - 2015-11-20 16:00:19,801 DEBUG : BROWSER_OUTPUT: 16:00:19 INFO - 2015-11-20 16:00:19,801 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.30 Median:91.50 stddev:17.06 (18.6%) stddev-sans-first:17.69 16:00:19 INFO - 2015-11-20 16:00:19,801 DEBUG : BROWSER_OUTPUT: Values: 92.0 92.0 127.0 91.0 92.0 93.0 126.0 91.0 91.0 128.0 16:00:19 INFO - 2015-11-20 16:00:19,801 DEBUG : BROWSER_OUTPUT: 16:00:19 INFO - 2015-11-20 16:00:19,801 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 16:00:19 INFO - 2015-11-20 16:00:19,801 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 110.0 109.0 109.0 109.0 110.0 109.0 109.0 16:00:19 INFO - 2015-11-20 16:00:19,802 DEBUG : BROWSER_OUTPUT: 16:00:19 INFO - 2015-11-20 16:00:19,802 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.80 Median:146.50 stddev:1.55 (1.1%) stddev-sans-first:1.62 16:00:19 INFO - 2015-11-20 16:00:19,802 DEBUG : BROWSER_OUTPUT: Values: 146.0 151.0 146.0 146.0 146.0 147.0 146.0 147.0 146.0 147.0 16:00:19 INFO - 2015-11-20 16:00:19,802 DEBUG : BROWSER_OUTPUT: 16:00:19 INFO - 2015-11-20 16:00:19,802 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.50 16:00:19 INFO - 2015-11-20 16:00:19,802 DEBUG : BROWSER_OUTPUT: Values: 94.0 95.0 96.0 95.0 95.0 96.0 96.0 95.0 95.0 95.0 16:00:19 INFO - 2015-11-20 16:00:19,802 DEBUG : BROWSER_OUTPUT: 16:00:19 INFO - 2015-11-20 16:00:19,802 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.60 Median:71.00 stddev:2.76 (3.9%) stddev-sans-first:2.92 16:00:19 INFO - 2015-11-20 16:00:19,802 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 72.0 70.0 71.0 72.0 71.0 79.0 70.0 69.0 16:00:19 INFO - 2015-11-20 16:00:19,803 DEBUG : BROWSER_OUTPUT: 16:00:19 INFO - 2015-11-20 16:00:19,803 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:69.00 stddev:1.52 (2.2%) stddev-sans-first:1.58 16:00:19 INFO - 2015-11-20 16:00:19,803 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 69.0 68.0 69.0 68.0 69.0 73.0 68.0 68.0 16:00:19 INFO - 2015-11-20 16:00:19,803 DEBUG : BROWSER_OUTPUT: 16:00:19 INFO - 2015-11-20 16:00:19,803 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:85.00 stddev:1.42 (1.7%) stddev-sans-first:1.50 16:00:19 INFO - 2015-11-20 16:00:19,803 DEBUG : BROWSER_OUTPUT: Values: 85.0 85.0 83.0 83.0 84.0 83.0 85.0 86.0 86.0 87.0 16:00:19 INFO - 2015-11-20 16:00:19,803 DEBUG : BROWSER_OUTPUT: 16:00:19 INFO - 2015-11-20 16:00:19,803 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.40 Median:127.00 stddev:4.40 (3.5%) stddev-sans-first:4.37 16:00:19 INFO - 2015-11-20 16:00:19,803 DEBUG : BROWSER_OUTPUT: Values: 120.0 120.0 122.0 120.0 127.0 128.0 120.0 127.0 129.0 131.0 16:00:19 INFO - 2015-11-20 16:00:19,804 DEBUG : BROWSER_OUTPUT: 16:00:19 INFO - 2015-11-20 16:00:19,804 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.30 Median:145.00 stddev:7.96 (5.5%) stddev-sans-first:8.33 16:00:19 INFO - 2015-11-20 16:00:19,804 DEBUG : BROWSER_OUTPUT: Values: 147.0 134.0 141.0 137.0 143.0 138.0 148.0 151.0 159.0 135.0 16:00:19 INFO - 2015-11-20 16:00:19,804 DEBUG : BROWSER_OUTPUT: 16:00:19 INFO - 2015-11-20 16:00:19,804 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:70.00 stddev:1.34 (1.9%) stddev-sans-first:1.41 16:00:19 INFO - 2015-11-20 16:00:19,804 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 70.0 71.0 69.0 71.0 70.0 68.0 68.0 67.0 16:00:19 INFO - 2015-11-20 16:00:19,804 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:00:19 INFO - 2015-11-20 16:00:19,804 DEBUG : BROWSER_OUTPUT: 16:00:20 INFO - 2015-11-20 16:00:20,733 INFO : Browser exited with error code: 0 16:00:20 INFO - 2015-11-20 16:00:20,784 INFO : Completed test kraken (00:01:00) 16:00:20 INFO - 2015-11-20 16:00:20,784 INFO : Starting test v8_7 16:00:20 INFO - 2015-11-20 16:00:20,784 DEBUG : operating with platform_type : linux_ 16:00:20 INFO - 2015-11-20 16:00:20,784 INFO : Initialising browser for v8_7 test... 16:00:20 INFO - 2015-11-20 16:00:20,790 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6kePQd/profile http://localhost:59928/getInfo.html 16:00:25 INFO - 2015-11-20 16:00:25,181 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:00:25 INFO - 2015-11-20 16:00:25,181 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:00:25 INFO - 2015-11-20 16:00:25,182 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:00:25 INFO - 2015-11-20 16:00:25,182 DEBUG : BROWSER_OUTPUT: __metrics 16:00:25 INFO - 2015-11-20 16:00:25,303 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:00:26 INFO - 2015-11-20 16:00:26,611 INFO : Browser initialized. 16:00:26 INFO - 2015-11-20 16:00:26,612 INFO : Running cycle 1/1 for v8_7 test... 16:00:26 INFO - 2015-11-20 16:00:26,612 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6kePQd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:00:38 INFO - 2015-11-20 16:00:38,591 DEBUG : BROWSER_OUTPUT: RSS: Main: 141500416 16:00:38 INFO - 2015-11-20 16:00:38,591 DEBUG : BROWSER_OUTPUT: 16:01:00 INFO - 2015-11-20 16:01:00,046 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59928/tests/v8_7/run.html (next: http://localhost:59928/tests/v8_7/run.html) 16:01:00 INFO - 2015-11-20 16:01:00,296 DEBUG : BROWSER_OUTPUT: RSS: Main: 440291328 16:01:00 INFO - 2015-11-20 16:01:00,296 DEBUG : BROWSER_OUTPUT: 16:01:00 INFO - 2015-11-20 16:01:00,297 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:01:00 INFO - 2015-11-20 16:01:00,297 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:01:00 INFO - 2015-11-20 16:01:00,297 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:01:00 INFO - 2015-11-20 16:01:00,297 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:01:00 INFO - 2015-11-20 16:01:00,297 DEBUG : BROWSER_OUTPUT: |0;Richards;162.91951775822744 16:01:00 INFO - 2015-11-20 16:01:00,297 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;192.23375624759709 16:01:00 INFO - 2015-11-20 16:01:00,297 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.9400278940028 16:01:00 INFO - 2015-11-20 16:01:00,297 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5045.226130653266 16:01:00 INFO - 2015-11-20 16:01:00,298 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2004.0080160320642 16:01:00 INFO - 2015-11-20 16:01:00,298 DEBUG : BROWSER_OUTPUT: |5;Earley;789.2659826361484 16:01:00 INFO - 2015-11-20 16:01:00,298 DEBUG : BROWSER_OUTPUT: |6;Boyer;12345.67901234568 16:01:00 INFO - 2015-11-20 16:01:00,298 DEBUG : BROWSER_OUTPUT: |7;RegExp;27216.216216216217 16:01:00 INFO - 2015-11-20 16:01:00,298 DEBUG : BROWSER_OUTPUT: |8;Splay;597.3715651135007 16:01:00 INFO - 2015-11-20 16:01:00,298 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 16:01:00 INFO - 2015-11-20 16:01:00,298 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:01:00 INFO - 2015-11-20 16:01:00,298 DEBUG : BROWSER_OUTPUT: __startTimestamp1448064060294__endTimestamp 16:01:00 INFO - 2015-11-20 16:01:00,299 DEBUG : BROWSER_OUTPUT: 16:01:00 INFO - 2015-11-20 16:01:00,299 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:01:00 INFO - 2015-11-20 16:01:00,299 DEBUG : BROWSER_OUTPUT: Number of tests: 10 16:01:00 INFO - 2015-11-20 16:01:00,299 DEBUG : BROWSER_OUTPUT: 16:01:00 INFO - 2015-11-20 16:01:00,299 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:162.92 Median:162.92 stddev:0.00 (0.0%) 16:01:00 INFO - 2015-11-20 16:01:00,299 DEBUG : BROWSER_OUTPUT: Values: 162.9 16:01:00 INFO - 2015-11-20 16:01:00,299 DEBUG : BROWSER_OUTPUT: 16:01:00 INFO - 2015-11-20 16:01:00,299 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:192.23 Median:192.23 stddev:0.00 (0.0%) 16:01:00 INFO - 2015-11-20 16:01:00,300 DEBUG : BROWSER_OUTPUT: Values: 192.2 16:01:00 INFO - 2015-11-20 16:01:00,300 DEBUG : BROWSER_OUTPUT: 16:01:00 INFO - 2015-11-20 16:01:00,300 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.94 Median:278.94 stddev:0.00 (0.0%) 16:01:00 INFO - 2015-11-20 16:01:00,300 DEBUG : BROWSER_OUTPUT: Values: 278.9 16:01:00 INFO - 2015-11-20 16:01:00,300 DEBUG : BROWSER_OUTPUT: 16:01:00 INFO - 2015-11-20 16:01:00,300 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5045.23 Median:5045.23 stddev:0.00 (0.0%) 16:01:00 INFO - 2015-11-20 16:01:00,300 DEBUG : BROWSER_OUTPUT: Values: 5045.2 16:01:00 INFO - 2015-11-20 16:01:00,300 DEBUG : BROWSER_OUTPUT: 16:01:00 INFO - 2015-11-20 16:01:00,301 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2004.01 Median:2004.01 stddev:0.00 (0.0%) 16:01:00 INFO - 2015-11-20 16:01:00,301 DEBUG : BROWSER_OUTPUT: Values: 2004.0 16:01:00 INFO - 2015-11-20 16:01:00,301 DEBUG : BROWSER_OUTPUT: 16:01:00 INFO - 2015-11-20 16:01:00,301 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:789.27 Median:789.27 stddev:0.00 (0.0%) 16:01:00 INFO - 2015-11-20 16:01:00,301 DEBUG : BROWSER_OUTPUT: Values: 789.3 16:01:00 INFO - 2015-11-20 16:01:00,302 DEBUG : BROWSER_OUTPUT: 16:01:00 INFO - 2015-11-20 16:01:00,303 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12345.68 Median:12345.68 stddev:0.00 (0.0%) 16:01:00 INFO - 2015-11-20 16:01:00,303 DEBUG : BROWSER_OUTPUT: Values: 12345.7 16:01:00 INFO - 2015-11-20 16:01:00,303 DEBUG : BROWSER_OUTPUT: 16:01:00 INFO - 2015-11-20 16:01:00,303 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27216.22 Median:27216.22 stddev:0.00 (0.0%) 16:01:00 INFO - 2015-11-20 16:01:00,303 DEBUG : BROWSER_OUTPUT: Values: 27216.2 16:01:00 INFO - 2015-11-20 16:01:00,303 DEBUG : BROWSER_OUTPUT: 16:01:00 INFO - 2015-11-20 16:01:00,303 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:597.37 Median:597.37 stddev:0.00 (0.0%) 16:01:00 INFO - 2015-11-20 16:01:00,303 DEBUG : BROWSER_OUTPUT: Values: 597.4 16:01:00 INFO - 2015-11-20 16:01:00,303 DEBUG : BROWSER_OUTPUT: 16:01:00 INFO - 2015-11-20 16:01:00,304 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 16:01:00 INFO - 2015-11-20 16:01:00,304 DEBUG : BROWSER_OUTPUT: Values: 4830.9 16:01:00 INFO - 2015-11-20 16:01:00,304 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:01:00 INFO - 2015-11-20 16:01:00,304 DEBUG : BROWSER_OUTPUT: 16:01:01 INFO - 2015-11-20 16:01:01,233 INFO : Browser exited with error code: 0 16:01:01 INFO - 2015-11-20 16:01:01,248 INFO : Completed test v8_7 (00:00:40) 16:01:01 INFO - 2015-11-20 16:01:01,301 INFO : Completed test suite (00:20:18) 16:01:01 INFO - 2015-11-20 16:01:01,302 DEBUG : Working with test: dromaeo_css 16:01:01 INFO - 2015-11-20 16:01:01,302 DEBUG : Generating results file: dromaeo_css 16:01:01 INFO - 2015-11-20 16:01:01,303 DEBUG : Working with test: kraken 16:01:01 INFO - 2015-11-20 16:01:01,303 DEBUG : Generating results file: kraken 16:01:01 INFO - 2015-11-20 16:01:01,303 INFO : javascript benchmark 16:01:01 INFO - 2015-11-20 16:01:01,303 DEBUG : Working with test: v8_7 16:01:01 INFO - 2015-11-20 16:01:01,303 DEBUG : Generating results file: v8_7 16:01:01 INFO - 2015-11-20 16:01:01,304 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:01:01 INFO - 2015-11-20 16:01:01,359 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,94,35]] 16:01:01 INFO - 2015-11-20 16:01:01,359 DEBUG : process_Request line: dromaeo_css 6307.72 graph.html#tests=[[72,94,35]] 16:01:01 INFO - 2015-11-20 16:01:01,359 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:01:01 INFO - 2015-11-20 16:01:01,391 DEBUG : process_Request line: kraken 1517.90 graph.html#tests=[[232,94,35]] 16:01:01 INFO - 2015-11-20 16:01:01,391 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:01:01 INFO - 2015-11-20 16:01:01,421 DEBUG : process_Request line: v8_7 19789.64 graph.html#tests=[[230,94,35]] 16:01:01 INFO - 2015-11-20 16:01:01,422 INFO : javascript benchmark 16:01:01 INFO - 2015-11-20 16:01:01,426 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2637.3274814922192, 2725.9075965217735, 2727.1682136948234, 2728.413391120911, 2752.7109653486395, 4569.154706379314, 4681.4382274127065, 4817.975910120449, 4818.08456393285, 4841.080194762997, 4715.717056976584, 4734.479207287196, 4735.668503204777, 4853.902921941568, 4854.805807767694, 4395.736255824653, 4412.183746006983, 4415.293553031515, 4434.711743736663, 4435.112977404532, 4199.874003779892, 4523.819047238107, 4527.615152712024, 4566.0, 4588.7476188809605, 4261.808218630169, 4331.805068771912, 4334.653227741773, 4365.170617582665, 4388.517263101056, 4362.389265502832, 4386.539413361615, 4386.605205531518, 4405.273129933557, 4414.028913638995, 4184.456020717318, 4297.4413326267695, 4363.214621368153, 4372.147431250907, 4423.491298500681, 4519.525449827786, 4601.608863246628, 4681.157391669498, 4692.7653617319, 4720.3863497745415, 5174.197999310113, 5232.215167724834, 5238.659487133362, 5245.895082098375, 5285.709285989269, 4890.462049174588, 5009.07332143551, 5251.133562962106, 5254.894902101936, 5257.18513630384, 4651.372064771246, 4696.365990591295, 4701.48283688794, 4702.0, 4747.240441529408, 5340.06548853949, 5384.030874442638, 5384.273123128406, 5384.434634363335, 5388.811391601275, 4778.235482322812, 4902.583280421133, 5151.871203219875, 5153.896922061538, 5190.948090519122, 5077.1876499759865, 5147.819826306061, 5235.554977826851, 5256.1327380982475, 5294.629375943647, 5181.5077567631015, 5184.0, 5184.766685499086, 5195.896082078413, 5239.109351410193, 5169.4572069932865, 5177.534021937969, 5179.249008893689, 5180.922286165711, 5183.429822719498, 4080.5103387593085, 4158.293090174678, 4200.957990420056, 4201.495820501559, 4242.575742425733, 3782.0922978485514, 3782.6028267032116, 3800.201957588937, 3818.0, 3842.001079719293, 4422.270325396338, 4434.578715022068, 4435.778211089432, 4436.955630443719, 4475.820967161277, 4903.583195428429, 4958.553730164231, 4966.379202599675, 5167.896642067138, 5238.580913526985, 4225.19721252961, 4248.299030659969, 4342.370356298319, 4452.621527170162, 4468.017036252019, 4622.029373831533, 4627.120847039052, 4631.066362652093, 4633.49031606523, 4677.625789936865, 4866.367372241586, 4869.853904382874, 4871.561559459666, 4916.704997700078, 4926.039422312686, 4941.332920055746, 4988.900221995613, 5093.108705976365, 5098.133317336136, 5110.412302585101, 4816.0, 4844.297576851266, 4848.927266091082, 4897.0, 4939.185034469272, 5039.0, 5080.618953578571, 5094.133997220555, 5096.566791822736, 5126.4360920297995, 4876.756162191805, 4994.200927851526, 5005.524475174852, 5093.949060509348, 5154.61340399464, 4983.526564976321, 4985.351904252424, 4987.451380348086, 5001.524855138756, 5012.974935125301, 4967.155583550732, 4970.527799859007, 4980.975095124501, 5005.599552035901, 5021.748912554284, 4644.256918892961, 4760.880977975578, 4767.356406885026, 4817.662763606514, 4928.852134435972, 5050.747462626928, 5053.393592768891, 5055.0, 5072.1123803335, 5116.0, 4914.631402644744, 4928.753562321941, 4929.482404347636, 4932.383452068491, 4981.676191047571], "unit": "ms", "name": "dojo.html", "value": 4696.045380700748}, {"lowerIsBetter": false, "replicates": [558.1773477157361, 574.2391331485783, 579.6666916523001, 587.1515659871486, 595.0122796158378, 28642.71357286429, 34093.829530852345, 34641.30717385654, 34667.826660866725, 34802.12994675128, 40662.0, 41119.383209251886, 41355.17289654205, 41484.17031659365, 41498.58501414985, 6973.058637083979, 7094.822629434254, 7945.721899733496, 8077.717279895205, 8140.3487720982175, 10166.796664066715, 10396.896031039669, 10419.635312764054, 10432.374057556533, 10435.843462348033, 10120.08919197272, 10194.0, 10217.795644087113, 10233.692989210298, 10235.232357573175, 7176.533525320863, 7229.674664640103, 7294.708211671526, 7320.67056982437, 10025.147862431702, 7022.19244786851, 10215.284930054899, 10445.529951152217, 10453.84319235212, 10471.581136754521, 37597.0, 38255.42616860749, 38411.0, 38418.23163536742, 38492.0, 3077.415291094685, 3629.491871138043, 3633.963660363389, 3669.376206044979, 3679.7792132472136, 28275.717242827515, 28645.856770716015, 28791.712082879112, 29132.27169320784, 29182.854085729647, 3291.2594666200152, 3310.702036816698, 3369.0903456066726, 3395.813230272334, 3397.21863971288, 221236.0, 223073.0, 223394.0, 223716.0, 224288.0, 51476.48523514792, 52788.472115279124, 56587.43412565822, 56936.43063569394, 57133.42866571281, 66780.0, 67317.6634116836, 67678.86335344665, 67706.0, 67732.0, 13054.738905221842, 13280.269585172908, 13299.13555618901, 13318.267495287851, 13352.799708004388, 10023.899761002296, 10101.19190464761, 10124.038216369434, 10138.797224055477, 10148.035936586013, 19050.333238336592, 19207.231710731416, 19312.80687193138, 19480.38360941587, 19595.510112247306, 7249.202587715347, 7623.809404764926, 7634.6946122154495, 7635.656395462218, 7652.196519365387, 816.4285000499674, 819.6598411659214, 885.5527958380976, 903.9141281578239, 979.0845559401982, 26096.0, 26284.21147365582, 26302.47395052088, 26429.207123786317, 26533.33666658349, 910.7040211931148, 951.8905325887473, 961.245422343457, 966.9371490853072, 1001.9849702254472, 14312.713745725026, 14905.627359315888, 14905.850941490446, 15028.549143525712, 15182.620434489005, 318270.0, 326403.0, 326521.0, 326770.0, 326843.0, 49233.50766492361, 49751.50248497541, 49770.502294976584, 49824.750876246115, 49835.0, 1234.493857518413, 1235.5799028330412, 1254.7866862633375, 1256.7926292161874, 1257.0948916779903, 25833.225003249932, 27223.0, 27266.009606263233, 27329.310543077227, 27639.447211056067, 36647.63352366549, 37078.8146059268, 37114.814425927696, 40622.0, 41173.0, 318519.0, 323249.0, 326661.0, 327351.0, 327353.0, 24426.75573244316, 24863.751362486142, 29888.057276276973, 30337.393252134392, 30449.391012180076, 37734.62265377311, 38300.23399531938, 38942.80528597339, 39781.40327895142, 39891.60108398879, 29399.805621119962, 32697.836510817295, 33111.50332744962, 33265.66734332722, 33748.49377259294, 33293.16767080843, 33409.665903340654, 33599.0, 33620.66379336175, 33728.66271337353, 33011.0, 33134.33731325312, 33329.83335083309, 33539.32921341608, 33575.49636755402, 28403.573946391232, 29552.704472954996, 30243.546346805255, 30274.940377086696, 30295.09114726562, 23534.882325588263, 23589.174378896656, 23889.761102388755, 23891.283261502183, 23975.400614984766], "unit": "ms", "name": "ext.html", "value": 17574.960162019506}, {"lowerIsBetter": false, "replicates": [309.5975232198142, 317.24337455169416, 320.7129618991004, 321.77475766963124, 327.80004197439575, 12785.872141278585, 13277.46890124394, 15884.682306353867, 16332.0, 16421.178941052945, 13414.865851341483, 13923.860761392383, 14317.78523322151, 14723.779143312831, 14738.336774845131, 4333.0, 4935.55579997801, 4966.230234313687, 5016.673916195436, 5098.005888851675, 5048.974755126219, 5065.924011139836, 5089.7964081436885, 5090.872728181788, 5091.032703786287, 5049.394072711261, 5050.646454748169, 5051.949480505203, 5079.695218286896, 5244.79020839166, 5193.298904647881, 5212.687238765686, 5213.895722085537, 5219.530242278175, 5221.503957124086, 4986.601071914238, 5008.048470790538, 5015.32293140425, 5022.447530771612, 5163.432022477525, 11860.703482412922, 11869.881301186964, 12037.0, 12050.337231452266, 17413.825861741472, 1773.698471259889, 1773.9556511087196, 1791.70436877915, 1792.5697832520232, 1855.3042609021618, 9022.233110185642, 9787.620546061904, 10766.0, 12597.874021259762, 12960.675983100404, 1577.2744537512758, 1583.4853672556465, 1659.9336026558924, 1688.2824799460302, 1736.513776142682, 52430.47569524332, 55012.0, 55471.0, 55788.72105639446, 55844.720776396265, 9448.196903263162, 9503.384424647826, 9513.857292140623, 9567.521623918776, 9583.664571739955, 10358.844617330746, 10572.577096916191, 11633.88366116328, 12076.818847717292, 12086.87913120875, 6109.541784366191, 6205.6586887721605, 6279.560430769893, 6402.103705481236, 6408.391202835724, 6010.699465026732, 6056.121862329937, 6198.287196972406, 6220.595661282002, 6234.719437625317, 4093.3041382964966, 4103.4870641169855, 4135.58644135584, 4146.460960075231, 4175.791210439526, 1687.907165105931, 1692.4668729350215, 1732.471596163157, 1740.904250266222, 1763.8588912886937, 844.4173520270994, 881.3213825354569, 885.818407226517, 948.9810203795886, 958.6644674364056, 15741.921290393475, 15914.30681115157, 16010.9199454002, 16174.27215775293, 16243.51269461918, 772.424543714936, 822.3174764945081, 869.1873098652779, 926.5969303353063, 964.1997142371814, 8338.62476188573, 8504.596741537576, 8663.783405414915, 8679.783005424915, 8826.293896488265, 477759.0, 485176.0, 487527.0, 489446.0, 502723.0, 68575.0, 69282.0, 69563.0, 69883.65058174779, 70216.0, 1044.5404022230346, 1046.1473898772476, 1047.7171163785736, 1050.4747626186906, 1053.2679787547581, 11714.297142171497, 13217.537386191438, 13372.927196284592, 13699.931500342434, 13754.105983111065, 24836.50326993414, 25294.620580690935, 30030.849845750632, 31377.686223137476, 31721.841390793823, 36305.461817272844, 36857.447138293486, 37947.620523795515, 38128.04679883025, 38258.0, 8571.057183709661, 8707.564621769014, 8888.33337499703, 9059.456432614064, 9072.727818165466, 10379.584816607252, 12594.748105038032, 15740.0, 15998.200089995686, 16479.83520164783, 13253.403596837972, 13558.86441135576, 13603.79594306106, 13887.930560347133, 14185.148891066568, 12457.563985260473, 12518.937405312916, 13314.400851961878, 13316.866831331563, 13323.400446980104, 13317.134386264861, 13347.733045339233, 13455.259960702255, 13637.181769093886, 13723.382447789674, 8307.709230176915, 8565.314774818124, 8579.742607721779, 8619.91380086191, 8654.956725216334, 12858.807117893051, 12923.159994600697, 13080.215187088805, 13211.735765284448, 13358.864496517905], "unit": "ms", "name": "jquery.html", "value": 7975.38313807802}, {"lowerIsBetter": false, "replicates": [1447.2329665277393, 1606.7670187822766, 1688.7973443186816, 1689.2820551265718, 1722.9569260768487, 5794.391588883164, 6685.264620891704, 6847.931520684791, 6853.246142924274, 6865.485088618361, 6674.199096108462, 6771.085903403039, 6776.390124888759, 6778.45772338213, 6782.796516104512, 1762.5769815244378, 1804.4496428589275, 2007.1569940624936, 2025.9392218233402, 2028.9492762680977, 2044.2845004248468, 2049.5593447408805, 2053.58928214357, 2055.219016773624, 2055.2806517718827, 1995.8303544198761, 2002.3392280547457, 2030.2183659291206, 2030.248807941064, 2033.7559492860803, 1989.4628450318478, 2004.5790384019301, 2024.7570291565107, 2025.625259327022, 2032.8272096871783, 2024.0891598780609, 2040.7653119891254, 2043.3869839048225, 2046.6009128220003, 2047.2015913793632, 6911.3779759821355, 6979.546329488567, 6983.336583024605, 6993.47548933832, 6994.6152961587095, 3949.2299001694396, 4009.879703608867, 4032.7983600819844, 4043.0903046814524, 4044.716869819114, 2195.078067211775, 2572.935676608081, 2707.7833773298285, 2728.6725592928974, 2740.4656092062055, 764.7094104240354, 831.7274569907989, 840.6385254340631, 856.498948115347, 876.023234093987, 9300.627974880997, 9396.154346108882, 9410.95294523523, 9437.24502039842, 9442.055794420503, 3904.941425878614, 3921.6078392160557, 3988.940165897514, 4005.7997100144876, 4017.799110044486, 8058.597070146469, 8062.0, 8062.7581172564915, 8065.919340806634, 8076.515409075474, 4055.533613634411, 4089.672826173899, 4093.2018256440306, 4110.219058378899, 4119.299719047769, 3667.9083022924106, 3691.483192353019, 3694.0210844126327, 3694.168812017275, 3698.056995466193, 3411.488276758506, 3424.07549961514, 3424.503447000171, 3438.1920248741526, 3443.380191565542, 993.8608594796734, 1004.1715584642699, 1014.2950649298814, 1026.4252018869456, 1032.829583118792, 1182.798924182891, 1183.6094088950626, 1186.9169158159018, 1202.5911190195375, 1203.1096988228649, 6467.450266727381, 6496.837579060561, 6530.836729081716, 6545.050967609765, 6562.081308616797, 396.71634781131627, 397.7911596411849, 398.27911480220894, 399.21354930786305, 404.7005216140035, 5237.319148510745, 5329.813456529003, 5330.360356757214, 5331.493508116722, 5333.839984800462, 8136.55248961301, 8253.174682531699, 8436.493810371398, 8464.238218560358, 8472.364572657076, 8351.0, 8359.205875441823, 8405.663773448994, 8412.537310447862, 8422.199891010345, 6290.308066112724, 6555.049517819984, 6655.767048153291, 6657.400833924873, 6663.733450661919, 6262.68686565679, 6474.708638111202, 6513.3161018094315, 6539.901901471387, 6588.8352791180605, 7449.515781474187, 7488.775336739906, 7490.588017659081, 7500.0, 7516.060492438445, 7557.697692092254, 7597.050368703912, 7700.075990881131, 7776.961115194388, 7797.064352277763, 6682.064510968566, 6764.425023873026, 6768.187817461936, 6772.390484856386, 6775.966120169368, 6591.472682185509, 6726.932730672631, 6739.427148692416, 6765.323467653196, 6788.558743681645, 6207.255129384503, 6267.0, 6342.080398342307, 6350.301466838737, 6433.067205255305, 6258.687065646791, 6337.302896681269, 6348.460380867678, 6361.045843123568, 6432.2281326241155, 6211.099390588249, 6277.246730392382, 6337.112804207507, 6347.143135676624, 6347.39699728525, 6004.489618382487, 6058.5758996871555, 6068.211132552917, 6073.5748497604745, 6076.665783381956, 5970.0746384310505, 6023.759049637965, 6028.819135425944, 6064.545159113172, 6069.544784141295], "unit": "ms", "name": "mootools.html", "value": 3938.9501046991586}, {"lowerIsBetter": false, "replicates": [293.95149800282957, 300.75187969924804, 302.17807563427476, 305.62255614316314, 308.12646148169944, 5407.0, 5498.010358135534, 5512.641678290918, 5516.668999860011, 5533.833984980457, 5160.974195129019, 5248.501392367729, 5316.494932981361, 5388.326459192601, 5410.053240682884, 4235.682323825726, 4240.893977650568, 4244.4906611206625, 4247.235497610429, 4256.659467242614, 4005.679545636342, 4227.978860105711, 4238.919075635708, 4240.830366785325, 4243.511996120439, 4058.5738497457783, 4060.2691515527194, 4162.209180255742, 4164.27125253081, 4208.747475151501, 4152.0, 4202.411662367271, 4205.915881682365, 4213.389058586487, 4214.241436541437, 3699.26014797039, 3701.1117331840433, 3702.8148592570265, 3704.7221458390727, 3708.072981754561, 5173.275741396207, 5222.973885130588, 5224.164133738584, 5228.320318358627, 5230.476952304777, 4648.907021859543, 4775.355327030841, 4806.182948898696, 4811.663183577151, 4875.219964805649, 5713.085906255021, 5719.6854173020465, 5728.742206600713, 5729.541636669098, 5733.627314224562, 3941.5664276929515, 3944.191440754667, 3946.4869566956113, 3947.032976920644, 3947.7631342119566, 5936.673482958436, 6012.278526576839, 6014.609050411709, 6027.547933904974, 6028.367021462727, 3930.5653436495472, 4055.1078762672164, 4061.614146656063, 4065.593440655911, 4070.043539768152, 4100.077482566398, 4101.7744024078365, 4119.402686610425, 4119.588041195856, 4124.154548317588, 4762.618990480753, 4774.069056533943, 4776.450708168605, 4776.47458779534, 4784.569388755029, 5775.27809023872, 5776.942230577724, 5781.595288329777, 5785.768569257182, 5787.652740835563, 1410.2948525737131, 1427.5717284814514, 1454.7163303155783, 1454.992725036368, 1459.9343029563695, 959.5346257065318, 961.0917682789836, 973.776031512756, 985.1232403161192, 985.8324084905584, 4899.363082799285, 4939.925901111486, 4970.975145124251, 4978.32792572998, 4981.128302547112, 5888.705564721747, 5899.646021238739, 5899.646021238739, 5902.61632993854, 5906.114082887601, 4879.170541008037, 4886.853394398174, 4941.703497790144, 4991.4758950310425, 5004.749762511859, 3208.2300247940793, 3222.113918672384, 3239.6436391996863, 3239.7408207343356, 3244.0592228254013, 5609.074502707089, 5632.436756324417, 5634.746436410372, 5640.0, 5643.673736671879, 6041.154238406627, 6128.3258841527395, 6158.476529495043, 6160.075988601746, 6173.536984726074, 5634.802781902614, 5634.943650563442, 5639.097744360883, 5640.661560306395, 5642.576806739511, 6001.549883758648, 6005.219321488178, 6008.5493587981955, 6013.789517366871, 6017.518598512021, 5804.622699524517, 5838.708064596668, 5839.036558967723, 5857.560682948882, 5869.413058694096, 5475.72621368922, 5587.525060369914, 5610.214569960291, 5626.409227031103, 5630.352509461464, 4058.0869304406274, 4058.2695114878425, 4058.330375488011, 4059.6143366380147, 4060.614241647039, 5979.611325263844, 5982.551308651781, 5991.3409524953095, 5993.280806303272, 6002.579819412599, 5633.267675202362, 5748.626339287933, 5758.395368486249, 5769.0481070624555, 5775.537956963349, 5766.94233057664, 5767.826965191051, 5780.421957804186, 5783.814318064702, 5784.248047753933, 5636.239107720406, 5636.943630563642, 5644.8306550803545, 5648.745806438802, 5660.773569057192, 5695.0, 5781.161731548986, 5826.82519524415, 5831.0, 5832.650040997553, 5649.067903795828, 5651.886962260814, 5653.915191272216, 5661.065924122474, 5661.971690141688], "unit": "ms", "name": "prototype.html", "value": 4289.208246625383}, {"lowerIsBetter": false, "replicates": [788.6017561131631, 791.295746785361, 795.2365728900259, 802.2058162419205, 811.8944537210161, 11182.66452006439, 11387.089032877371, 11389.08887289017, 11390.487428065737, 11412.54349826006, 11847.111466640015, 11943.462544185511, 11958.820617690742, 11958.880411195907, 11969.880301196985, 608.2245137449743, 624.9218847644045, 624.9750009999594, 777.3509119884903, 802.7993001749562, 798.7284323330067, 800.7437619961614, 805.7059173401695, 805.87508936115, 805.9677612895478, 832.937529685273, 839.0351096239343, 839.0812060793421, 840.6595328891779, 840.8108175660489, 630.9526785491083, 640.8910485217524, 811.4928169893816, 822.6956026270259, 825.8843761873343, 614.3733391940241, 616.9568130230886, 617.5461036138435, 617.8609812792131, 618.1068356225256, 11045.83431248532, 11147.832782508269, 11167.664970050912, 11185.161112916563, 11196.776064478747, 10917.945410272898, 11441.599544015919, 11491.42542872853, 11884.405779711067, 11937.522499100025, 8850.291976641918, 8863.645454181826, 8951.23914467271, 9020.864687029634, 9037.593308301077, 3222.065600975714, 3224.774265801395, 3250.414925313443, 3279.5572597699243, 3313.055779102944, 39857.40213896765, 40029.39955900664, 40066.19867602661, 40136.59863401387, 40283.395749063784, 8769.342299327576, 8914.509701966454, 8960.462372257685, 9038.231750301167, 9039.728808135766, 15216.391344346102, 15259.313330900137, 15262.236888155549, 15263.0, 15276.618084547754, 6222.81331560054, 6249.96875015622, 6339.239291284983, 6431.871362572816, 6465.094886715863, 3476.66971637694, 3582.3372676055014, 3611.133328001261, 3642.581103173116, 3702.129999450127, 2535.3915060385375, 2567.0373609896287, 2576.716561178269, 2582.2382397192873, 2583.4962182374634, 468.7703025517472, 473.98815029624535, 474.79821076042543, 485.30601240226815, 489.3662706794638, 459.37754342864935, 483.7943873853598, 567.9943200568024, 570.4409678514995, 581.102197105473, 7161.4279109768295, 7273.927260727325, 7293.8905916411295, 7303.780886573411, 7327.74352897646, 484.05125953132256, 570.8258981010831, 602.5270162922085, 605.5488660947534, 617.7776000639766, 3558.928821423557, 3603.612599164214, 3644.4168932970597, 3708.925821483609, 3710.5732840723663, 54892.45107548953, 55331.44668553343, 55381.446185538436, 55515.44484555103, 55552.0, 46708.766456167505, 47019.5298047022, 47434.76282618565, 47486.0, 47551.0, 42269.36595951063, 42546.36180457295, 42796.572034279256, 43434.0, 43441.34837977433, 7115.82210444743, 7267.382272506896, 7286.96356518214, 7412.555246685216, 7892.329152021913, 31167.376652467276, 31384.0, 32062.198445038128, 32184.83907580447, 32377.0, 40686.79656601698, 40877.79561102176, 40940.0, 41335.1732965345, 41798.791006044776, 9941.900580994097, 10006.09945104944, 10143.137833283958, 10180.949095254477, 10208.476654802236, 11133.435291530433, 11251.324920504796, 11325.660230193107, 11361.886381136082, 11723.41382930867, 10375.740606484898, 10394.74013149647, 10402.271840971362, 10438.895611043792, 10468.162546996375, 10312.432816195182, 10407.635732749317, 10587.947060264649, 10589.841152382567, 10652.041316281262, 10255.384676919408, 10420.270581059252, 10536.78926421452, 10673.839892401465, 10839.891601083888, 9038.819223615623, 9141.725748227564, 9328.766780830534, 9465.810683786423, 9471.10024547667, 8655.48067115975, 8733.519656418957, 8900.73297801067, 8932.374733768575, 8980.86528702083], "unit": "ms", "name": "yui.html", "value": 5663.067012327561}], "name": "dromaeo_css", "value": 6307.719480530208}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 112.0, 105.0, 110.0, 110.0, 112.0, 101.0, 112.0, 104.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 108.7}, {"lowerIsBetter": true, "replicates": [157.0, 130.0, 150.0, 174.0, 140.0, 153.0, 155.0, 141.0, 171.0, 130.0], "unit": "ms", "name": "audio-beat-detection", "value": 150.1}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 162.0, 163.0, 161.0, 160.0, 161.0, 163.0, 162.0, 160.0], "unit": "ms", "name": "audio-dft", "value": 161.6}, {"lowerIsBetter": true, "replicates": [72.0, 81.0, 84.0, 94.0, 71.0, 72.0, 75.0, 104.0, 91.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 81.7}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 127.0, 91.0, 92.0, 93.0, 126.0, 91.0, 91.0, 128.0], "unit": "ms", "name": "audio-oscillator", "value": 102.3}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 110.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [146.0, 151.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 72.0, 70.0, 71.0, 72.0, 71.0, 79.0, 70.0, 69.0], "unit": "ms", "name": "json-parse-financial", "value": 71.6}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 69.0, 68.0, 69.0, 68.0, 69.0, 73.0, 68.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.9}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 83.0, 83.0, 84.0, 83.0, 85.0, 86.0, 86.0, 87.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.7}, {"lowerIsBetter": true, "replicates": [120.0, 120.0, 122.0, 120.0, 127.0, 128.0, 120.0, 127.0, 129.0, 131.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 124.4}, {"lowerIsBetter": true, "replicates": [147.0, 134.0, 141.0, 137.0, 143.0, 138.0, 148.0, 151.0, 159.0, 135.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 143.3}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 70.0, 71.0, 69.0, 71.0, 70.0, 68.0, 68.0, 67.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.3}], "name": "kraken", "value": 1517.9}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [162.91951775822744], "unit": "score", "name": "Richards", "value": 216.6836759999999}, {"lowerIsBetter": false, "replicates": [192.23375624759709], "unit": "score", "name": "DeltaBlue", "value": 343.9458360000001}, {"lowerIsBetter": false, "replicates": [278.9400278940028], "unit": "score", "name": "Encrypt", "value": 954.2588850000001}, {"lowerIsBetter": false, "replicates": [5045.226130653266], "unit": "score", "name": "Decrypt", "value": 52.75898306772911}, {"lowerIsBetter": false, "replicates": [2004.0080160320642], "unit": "score", "name": "RayTrace", "value": 369.254511}, {"lowerIsBetter": false, "replicates": [789.2659826361484], "unit": "score", "name": "Earley", "value": 844.4086210000003}, {"lowerIsBetter": false, "replicates": [12345.67901234568], "unit": "score", "name": "Boyer", "value": 53.98350299999995}, {"lowerIsBetter": false, "replicates": [27216.216216216217], "unit": "score", "name": "RegExp", "value": 33.472140019860944}, {"lowerIsBetter": false, "replicates": [597.3715651135007], "unit": "score", "name": "Splay", "value": 136.41593400000002}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19789.64079901515}]} 16:01:01 INFO - RETURN: dromaeo_css: 6307.72 16:01:01 INFO - RETURN: kraken: 1517.90 16:01:01 INFO - RETURN: v8_7: 19789.64 16:01:01 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,35]]", "result": "19789.64"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,35]]", "result": "1517.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,35]]", "result": "6307.72"}}} 16:01:01 INFO - Return code: 0 16:01:01 INFO - # TBPL SUCCESS # 16:01:01 INFO - Running post-action listener: _resource_record_post_action 16:01:01 INFO - Running post-run listener: _resource_record_post_run 16:01:02 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 12288; Write bytes: 512163840; Read time: 244; Write time: 558988 16:01:02 INFO - install - Wall time: 14s; CPU: 16.0%; Read bytes: 4096; Write bytes: 196460544; Read time: 64; Write time: 221968 16:01:02 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 4096; Write bytes: 271708160; Read time: 160; Write time: 143020 16:01:02 INFO - Running post-run listener: _upload_blobber_files 16:01:02 INFO - Blob upload gear active. 16:01:02 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 16:01:02 INFO - Copying logs to upload dir... 16:01:02 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1271.761418 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2015-11-20 16:01:02.383547) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 16:01:02.387137) ========= 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=70a720fcaf18edea6683c2dc000001ad-1448058753.669034-1042241014 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/mwZ-J9TvQv2DFIRp0f6H5g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010068 build_url: 'https://queue.taskcluster.net/v1/task/mwZ-J9TvQv2DFIRp0f6H5g/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 16:01:02.438461) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 16:01:02.438775) ========= 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=70a720fcaf18edea6683c2dc000001ad-1448058753.669034-1042241014 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004629 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 16:01:02.488304) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 16:01:02.488614) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 16:01:02.488889) ========= ========= Total master_lag: 0.23 =========