builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-021 starttime: 1468238828.4 results: success (0) buildid: 20160711021319 builduid: b81e2b480c9746b681c6bdce7fb3ff22 revision: 0136b1e24160 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-11 05:07:08.404474) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-11 05:07:08.404973) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-11 05:07:08.405250) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-11 05:07:08.421580) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 05:07:08.422023) ========= 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=df17445c3590ff7897617a0e00000225-1468238827.513368-827136256 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-11 05:07:08-- 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% 23.4M=0s 2016-07-11 05:07:08 (23.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.116499 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 05:07:08.553870) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 05:07:08.554209) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', '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=df17445c3590ff7897617a0e00000225-1468238827.513368-827136256 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023807 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 05:07:08.604830) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-11 05:07:08.605210) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0136b1e24160 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 0136b1e24160 --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=df17445c3590ff7897617a0e00000225-1468238827.513368-827136256 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-11 05:07:08,669 Setting DEBUG logging. 2016-07-11 05:07:08,669 attempt 1/10 2016-07-11 05:07:08,669 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0136b1e24160?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-11 05:07:09,268 unpacking tar archive at: fx-team-0136b1e24160/testing/mozharness/ program finished with exit code 0 elapsedTime=0.929712 ========= master_lag: 0.26 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-11 05:07:09.796808) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-11 05:07:09.797134) ========= script_repo_revision: 0136b1e24160 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-11 05:07:09.800651) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-11 05:07:09.800996) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-11 05:07:10.079124) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-07-11 05:07:10.079581) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=df17445c3590ff7897617a0e00000225-1468238827.513368-827136256 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:07:10 INFO - MultiFileLogger online at 20160711 05:07:10 in /builds/slave/test 05:07:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:07:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:07:10 INFO - {'append_to_log': False, 05:07:10 INFO - 'base_work_dir': '/builds/slave/test', 05:07:10 INFO - 'blob_upload_branch': 'Fx-Team', 05:07:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:07:10 INFO - 'branch': 'Fx-Team', 05:07:10 INFO - 'buildbot_json_path': 'buildprops.json', 05:07:10 INFO - 'config_files': ('talos/linux_config.py',), 05:07:10 INFO - 'default_actions': ('clobber', 05:07:10 INFO - 'read-buildbot-config', 05:07:10 INFO - 'download-and-extract', 05:07:10 INFO - 'populate-webroot', 05:07:10 INFO - 'create-virtualenv', 05:07:10 INFO - 'install', 05:07:10 INFO - 'run-tests'), 05:07:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:07:10 INFO - 'download_minidump_stackwalk': True, 05:07:10 INFO - 'download_symbols': 'ondemand', 05:07:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:07:10 INFO - 'tooltool.py': '/tools/tooltool.py', 05:07:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:07:10 INFO - '/tools/misc-python/virtualenv.py')}, 05:07:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:07:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:07:10 INFO - 'installer_path': 'installer.exe', 05:07:10 INFO - 'log_level': 'info', 05:07:10 INFO - 'log_name': 'talos', 05:07:10 INFO - 'log_to_console': True, 05:07:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:07:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:07:10 INFO - 'opt_config_files': (), 05:07:10 INFO - 'pip_index': False, 05:07:10 INFO - 'sps_profile': False, 05:07:10 INFO - 'sps_profile_interval': 0, 05:07:10 INFO - 'suite': 'dromaeojs-e10s', 05:07:10 INFO - 'system_bits': '32', 05:07:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:07:10 INFO - 'title': 'talos-linux64-ix-021', 05:07:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:07:10 INFO - 'use_talos_json': True, 05:07:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:07:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:07:10 INFO - 'work_dir': 'build'} 05:07:10 INFO - ##### 05:07:10 INFO - ##### Running clobber step. 05:07:10 INFO - ##### 05:07:10 INFO - Running pre-action listener: _resource_record_pre_action 05:07:10 INFO - Running main action method: clobber 05:07:10 INFO - rmtree: /builds/slave/test/build 05:07:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:07:10 INFO - Running post-action listener: _resource_record_post_action 05:07:10 INFO - ##### 05:07:10 INFO - ##### Finished clobber step (success) 05:07:10 INFO - ##### 05:07:10 INFO - ##### 05:07:10 INFO - ##### Running read-buildbot-config step. 05:07:10 INFO - ##### 05:07:10 INFO - Running pre-action listener: _resource_record_pre_action 05:07:10 INFO - Running main action method: read_buildbot_config 05:07:10 INFO - Using buildbot properties: 05:07:10 INFO - { 05:07:10 INFO - "project": "", 05:07:10 INFO - "product": "firefox", 05:07:10 INFO - "script_repo_revision": "production", 05:07:10 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 05:07:10 INFO - "repository": "", 05:07:10 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 05:07:10 INFO - "buildid": "20160711021319", 05:07:10 INFO - "pgo_build": "True", 05:07:10 INFO - "basedir": "/builds/slave/test", 05:07:10 INFO - "buildnumber": 562, 05:07:10 INFO - "slavename": "talos-linux64-ix-021", 05:07:10 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:07:10 INFO - "platform": "ubuntu64_hw", 05:07:10 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:07:10 INFO - "branch": "fx-team", 05:07:10 INFO - "repo_path": "integration/fx-team", 05:07:10 INFO - "revision": "0136b1e24160", 05:07:10 INFO - "stage_platform": "linux64-pgo", 05:07:10 INFO - "builduid": "b81e2b480c9746b681c6bdce7fb3ff22", 05:07:10 INFO - "slavebuilddir": "test" 05:07:10 INFO - } 05:07:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/coEJbLhqTci38c6RWN6rzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:07:10 INFO - Running post-action listener: _resource_record_post_action 05:07:10 INFO - ##### 05:07:10 INFO - ##### Finished read-buildbot-config step (success) 05:07:10 INFO - ##### 05:07:10 INFO - ##### 05:07:10 INFO - ##### Running download-and-extract step. 05:07:10 INFO - ##### 05:07:10 INFO - Running pre-action listener: _resource_record_pre_action 05:07:10 INFO - Running main action method: download_and_extract 05:07:10 INFO - mkdir: /builds/slave/test/build/tests 05:07:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:10 INFO - https://queue.taskcluster.net/v1/task/coEJbLhqTci38c6RWN6rzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:07:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/coEJbLhqTci38c6RWN6rzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:07:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/coEJbLhqTci38c6RWN6rzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:07:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/coEJbLhqTci38c6RWN6rzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:07:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/coEJbLhqTci38c6RWN6rzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:07:11 INFO - Downloaded 1361 bytes. 05:07:11 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:07:11 INFO - Using the following test package requirements: 05:07:11 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:07:11 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:07:11 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:07:11 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:11 INFO - u'jsshell-linux-x86_64.zip'], 05:07:11 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:07:11 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:07:11 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:07:11 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:07:11 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:07:11 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:07:11 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:07:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:11 INFO - https://queue.taskcluster.net/v1/task/coEJbLhqTci38c6RWN6rzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:07:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/coEJbLhqTci38c6RWN6rzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:07:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/coEJbLhqTci38c6RWN6rzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:07:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/coEJbLhqTci38c6RWN6rzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:07:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/coEJbLhqTci38c6RWN6rzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:07:12 INFO - Downloaded 24304453 bytes. 05:07:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:07:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:07:14 INFO - Return code: 0 05:07:14 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:07:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:14 INFO - https://queue.taskcluster.net/v1/task/coEJbLhqTci38c6RWN6rzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:07:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/coEJbLhqTci38c6RWN6rzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:07:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/coEJbLhqTci38c6RWN6rzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:07:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/coEJbLhqTci38c6RWN6rzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:07:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/coEJbLhqTci38c6RWN6rzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:07:15 INFO - Downloaded 24304453 bytes. 05:07:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:07:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:07:16 INFO - Return code: 0 05:07:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:16 INFO - https://queue.taskcluster.net/v1/task/coEJbLhqTci38c6RWN6rzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:07:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/coEJbLhqTci38c6RWN6rzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:07:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/coEJbLhqTci38c6RWN6rzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:07:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/coEJbLhqTci38c6RWN6rzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:07:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/coEJbLhqTci38c6RWN6rzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:07:17 INFO - Downloaded 14403333 bytes. 05:07:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:07:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:07:17 INFO - Return code: 0 05:07: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')]} 05:07:17 INFO - https://queue.taskcluster.net/v1/task/coEJbLhqTci38c6RWN6rzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:07:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/coEJbLhqTci38c6RWN6rzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:07:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/coEJbLhqTci38c6RWN6rzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:07:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/coEJbLhqTci38c6RWN6rzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:07:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/coEJbLhqTci38c6RWN6rzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:07:22 INFO - Downloaded 60469528 bytes. 05:07:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/coEJbLhqTci38c6RWN6rzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:07:22 INFO - mkdir: /builds/slave/test/properties 05:07:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:07:22 INFO - Writing to file /builds/slave/test/properties/build_url 05:07:22 INFO - Contents: 05:07:22 INFO - build_url:https://queue.taskcluster.net/v1/task/coEJbLhqTci38c6RWN6rzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:07:23 INFO - Running post-action listener: _resource_record_post_action 05:07:23 INFO - Running post-action listener: set_extra_try_arguments 05:07:23 INFO - ##### 05:07:23 INFO - ##### Finished download-and-extract step (success) 05:07:23 INFO - ##### 05:07:23 INFO - ##### 05:07:23 INFO - ##### Running populate-webroot step. 05:07:23 INFO - ##### 05:07:23 INFO - Running pre-action listener: _resource_record_pre_action 05:07:23 INFO - Running main action method: populate_webroot 05:07:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:07:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:07:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:07:23 INFO - '--tppagecycles', 05:07:23 INFO - '7'], 05:07:23 INFO - 'tests': ['tsvgm']}}, 05:07:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:07:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:07:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:07:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:07:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:07:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:07:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:23 INFO - 'talos_options': ['--disable-e10s'], 05:07:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:07:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:07:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:23 INFO - 'talos_options': ['--disable-e10s'], 05:07:23 INFO - 'tests': ['damp', 'tps']}, 05:07:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:23 INFO - 'tests': ['damp', 'tps']}, 05:07:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:07:23 INFO - 'tests': ['dromaeo_dom']}, 05:07:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:07:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:07:23 INFO - 'tests': ['basic_compositor_video']}, 05:07:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:07:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:07:23 INFO - 'tests': ['a11yr', 05:07:23 INFO - 'ts_paint', 05:07:23 INFO - 'tpaint', 05:07:23 INFO - 'sessionrestore', 05:07:23 INFO - 'sessionrestore_no_auto_restore', 05:07:23 INFO - 'tabpaint']}, 05:07:23 INFO - 'other-e10s': {'tests': ['a11yr', 05:07:23 INFO - 'ts_paint', 05:07:23 INFO - 'tpaint', 05:07:23 INFO - 'sessionrestore', 05:07:23 INFO - 'sessionrestore_no_auto_restore', 05:07:23 INFO - 'tabpaint']}, 05:07:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:07:23 INFO - 'ts_paint', 05:07:23 INFO - 'tpaint', 05:07:23 INFO - 'sessionrestore', 05:07:23 INFO - 'sessionrestore_no_auto_restore', 05:07:23 INFO - 'tabpaint']}, 05:07:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:07:23 INFO - 'ts_paint', 05:07:23 INFO - 'tpaint', 05:07:23 INFO - 'sessionrestore', 05:07:23 INFO - 'sessionrestore_no_auto_restore', 05:07:23 INFO - 'tabpaint']}, 05:07:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:07:23 INFO - 'tests': ['a11yr', 05:07:23 INFO - 'ts_paint', 05:07:23 INFO - 'tpaint', 05:07:23 INFO - 'sessionrestore', 05:07:23 INFO - 'sessionrestore_no_auto_restore', 05:07:23 INFO - 'tabpaint']}, 05:07:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:07:23 INFO - 'tests': ['a11yr', 05:07:23 INFO - 'ts_paint', 05:07:23 INFO - 'tpaint', 05:07:23 INFO - 'sessionrestore', 05:07:23 INFO - 'sessionrestore_no_auto_restore', 05:07:23 INFO - 'tabpaint']}, 05:07:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:07:23 INFO - 'tests': ['tsvgx', 05:07:23 INFO - 'tsvgr_opacity', 05:07:23 INFO - 'tart', 05:07:23 INFO - 'tscrollx', 05:07:23 INFO - 'cart']}, 05:07:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:07:23 INFO - 'tsvgr_opacity', 05:07:23 INFO - 'tart', 05:07:23 INFO - 'tscrollx', 05:07:23 INFO - 'cart']}, 05:07:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:23 INFO - 'talos_options': ['--disable-e10s'], 05:07:23 INFO - 'tests': ['tp5o']}, 05:07:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:23 INFO - 'tests': ['tp5o']}, 05:07:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:23 INFO - 'talos_options': ['--disable-e10s', 05:07:23 INFO - '--xperf_path', 05:07:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:07:23 INFO - 'tests': ['tp5n']}, 05:07:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:23 INFO - 'talos_options': ['--xperf_path', 05:07:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:07:23 INFO - 'tests': ['tp5n']}}, 05:07:23 INFO - 'talos.zip': {'path': '', 05:07:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:07:23 INFO - Running post-action listener: _resource_record_post_action 05:07:23 INFO - ##### 05:07:23 INFO - ##### Finished populate-webroot step (success) 05:07:23 INFO - ##### 05:07:23 INFO - ##### 05:07:23 INFO - ##### Running create-virtualenv step. 05:07:23 INFO - ##### 05:07:23 INFO - Running pre-action listener: _resource_record_pre_action 05:07:23 INFO - Running main action method: create_virtualenv 05:07:23 INFO - Creating virtualenv /builds/slave/test/build/venv 05:07:23 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:07:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:07:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:07:23 INFO - Using real prefix '/usr' 05:07:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:07:24 INFO - Installing distribute.............................................................................................................................................................................................done. 05:07:26 INFO - Installing pip.................done. 05:07:26 INFO - Return code: 0 05:07:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:07:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x15df030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18a0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189e3b0>, '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 0x189f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x189f740>, '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': 'df17445c3590ff7897617a0e00000225-1468238827.513368-827136256', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:07:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:07:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:07:26 INFO - Using env: {'DISPLAY': ':0', 05:07:26 INFO - 'HOME': '/home/cltbld', 05:07:26 INFO - 'LANG': 'en_US.UTF-8', 05:07:26 INFO - 'LANGUAGE': 'en_US:en', 05:07:26 INFO - 'LOGNAME': 'cltbld', 05:07:26 INFO - 'MAIL': '/var/mail/cltbld', 05:07:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:26 INFO - 'MOZ_NO_REMOTE': '1', 05:07:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:26 INFO - 'NO_EM_RESTART': '1', 05:07:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:26 INFO - 'PWD': '/builds/slave/test', 05:07:26 INFO - 'SHELL': '/bin/bash', 05:07:26 INFO - 'SHLVL': '1', 05:07:26 INFO - 'TERM': 'linux', 05:07:26 INFO - 'TMOUT': '86400', 05:07:26 INFO - 'USER': 'cltbld', 05:07:26 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468238827.513368-827136256', 05:07:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:26 INFO - '_': '/tools/buildbot/bin/python'} 05:07:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:26 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:07:26 INFO - Cleaning up... 05:07:26 INFO - Return code: 0 05:07:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:07:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15df030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18a0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189e3b0>, '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 0x189f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x189f740>, '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': 'df17445c3590ff7897617a0e00000225-1468238827.513368-827136256', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:07:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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>=3.1.1'] in /builds/slave/test/build 05:07:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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>=3.1.1 05:07:26 INFO - Using env: {'DISPLAY': ':0', 05:07:26 INFO - 'HOME': '/home/cltbld', 05:07:26 INFO - 'LANG': 'en_US.UTF-8', 05:07:26 INFO - 'LANGUAGE': 'en_US:en', 05:07:26 INFO - 'LOGNAME': 'cltbld', 05:07:26 INFO - 'MAIL': '/var/mail/cltbld', 05:07:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:26 INFO - 'MOZ_NO_REMOTE': '1', 05:07:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:26 INFO - 'NO_EM_RESTART': '1', 05:07:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:26 INFO - 'PWD': '/builds/slave/test', 05:07:26 INFO - 'SHELL': '/bin/bash', 05:07:26 INFO - 'SHLVL': '1', 05:07:26 INFO - 'TERM': 'linux', 05:07:26 INFO - 'TMOUT': '86400', 05:07:26 INFO - 'USER': 'cltbld', 05:07:26 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468238827.513368-827136256', 05:07:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:26 INFO - '_': '/tools/buildbot/bin/python'} 05:07:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:26 INFO - Downloading/unpacking psutil>=3.1.1 05:07:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:07:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:07:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:07:28 INFO - Installing collected packages: psutil 05:07:28 INFO - Running setup.py install for psutil 05:07:28 INFO - building 'psutil._psutil_linux' extension 05:07:28 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:07:28 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:07:28 INFO - building 'psutil._psutil_posix' extension 05:07:28 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:07:28 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:07:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:07:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:07:29 INFO - Successfully installed psutil 05:07:29 INFO - Cleaning up... 05:07:29 INFO - Return code: 0 05:07:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:07:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15df030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18a0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189e3b0>, '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 0x189f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x189f740>, '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': 'df17445c3590ff7897617a0e00000225-1468238827.513368-827136256', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:07:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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.3'] in /builds/slave/test/build 05:07:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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.3 05:07:29 INFO - Using env: {'DISPLAY': ':0', 05:07:29 INFO - 'HOME': '/home/cltbld', 05:07:29 INFO - 'LANG': 'en_US.UTF-8', 05:07:29 INFO - 'LANGUAGE': 'en_US:en', 05:07:29 INFO - 'LOGNAME': 'cltbld', 05:07:29 INFO - 'MAIL': '/var/mail/cltbld', 05:07:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:29 INFO - 'MOZ_NO_REMOTE': '1', 05:07:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:29 INFO - 'NO_EM_RESTART': '1', 05:07:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:29 INFO - 'PWD': '/builds/slave/test', 05:07:29 INFO - 'SHELL': '/bin/bash', 05:07:29 INFO - 'SHLVL': '1', 05:07:29 INFO - 'TERM': 'linux', 05:07:29 INFO - 'TMOUT': '86400', 05:07:29 INFO - 'USER': 'cltbld', 05:07:29 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468238827.513368-827136256', 05:07:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:29 INFO - '_': '/tools/buildbot/bin/python'} 05:07:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:07:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:07:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:07:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:07:31 INFO - Installing collected packages: mozsystemmonitor 05:07:31 INFO - Running setup.py install for mozsystemmonitor 05:07:31 INFO - Successfully installed mozsystemmonitor 05:07:31 INFO - Cleaning up... 05:07:31 INFO - Return code: 0 05:07:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:07:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15df030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18a0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189e3b0>, '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 0x189f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x189f740>, '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': 'df17445c3590ff7897617a0e00000225-1468238827.513368-827136256', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:07:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:07:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 jsonschema==2.5.1 05:07:31 INFO - Using env: {'DISPLAY': ':0', 05:07:31 INFO - 'HOME': '/home/cltbld', 05:07:31 INFO - 'LANG': 'en_US.UTF-8', 05:07:31 INFO - 'LANGUAGE': 'en_US:en', 05:07:31 INFO - 'LOGNAME': 'cltbld', 05:07:31 INFO - 'MAIL': '/var/mail/cltbld', 05:07:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:31 INFO - 'MOZ_NO_REMOTE': '1', 05:07:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:31 INFO - 'NO_EM_RESTART': '1', 05:07:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:31 INFO - 'PWD': '/builds/slave/test', 05:07:31 INFO - 'SHELL': '/bin/bash', 05:07:31 INFO - 'SHLVL': '1', 05:07:31 INFO - 'TERM': 'linux', 05:07:31 INFO - 'TMOUT': '86400', 05:07:31 INFO - 'USER': 'cltbld', 05:07:31 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468238827.513368-827136256', 05:07:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:31 INFO - '_': '/tools/buildbot/bin/python'} 05:07:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:31 INFO - Downloading/unpacking jsonschema==2.5.1 05:07:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:07:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:07:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:33 INFO - Downloading functools32-3.2.3-2.tar.gz 05:07:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:07:33 INFO - warning: no files found matching '*.txt' 05:07:33 INFO - no previously-included directories found matching 'build' 05:07:33 INFO - no previously-included directories found matching 'dist' 05:07:33 INFO - no previously-included directories found matching '.git*' 05:07:33 INFO - Installing collected packages: jsonschema, functools32 05:07:33 INFO - Running setup.py install for functools32 05:07:33 INFO - warning: no files found matching '*.txt' 05:07:33 INFO - no previously-included directories found matching 'build' 05:07:33 INFO - no previously-included directories found matching 'dist' 05:07:33 INFO - no previously-included directories found matching '.git*' 05:07:33 INFO - Successfully installed jsonschema functools32 05:07:33 INFO - Cleaning up... 05:07:34 INFO - Return code: 0 05:07:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:07:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x15df030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18a0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189e3b0>, '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 0x189f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x189f740>, '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': 'df17445c3590ff7897617a0e00000225-1468238827.513368-827136256', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:07:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:07:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:07:34 INFO - Using env: {'DISPLAY': ':0', 05:07:34 INFO - 'HOME': '/home/cltbld', 05:07:34 INFO - 'LANG': 'en_US.UTF-8', 05:07:34 INFO - 'LANGUAGE': 'en_US:en', 05:07:34 INFO - 'LOGNAME': 'cltbld', 05:07:34 INFO - 'MAIL': '/var/mail/cltbld', 05:07:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:34 INFO - 'MOZ_NO_REMOTE': '1', 05:07:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:34 INFO - 'NO_EM_RESTART': '1', 05:07:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:34 INFO - 'PWD': '/builds/slave/test', 05:07:34 INFO - 'SHELL': '/bin/bash', 05:07:34 INFO - 'SHLVL': '1', 05:07:34 INFO - 'TERM': 'linux', 05:07:34 INFO - 'TMOUT': '86400', 05:07:34 INFO - 'USER': 'cltbld', 05:07:34 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468238827.513368-827136256', 05:07:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:34 INFO - '_': '/tools/buildbot/bin/python'} 05:07:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:34 INFO - Downloading/unpacking blobuploader==1.2.4 05:07:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:36 INFO - Downloading blobuploader-1.2.4.tar.gz 05:07:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:07:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:07:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:07:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:07:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:36 INFO - Downloading docopt-0.6.1.tar.gz 05:07:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:07:36 INFO - Installing collected packages: blobuploader, requests, docopt 05:07:36 INFO - Running setup.py install for blobuploader 05:07:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:07:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:07:36 INFO - Running setup.py install for requests 05:07:37 INFO - Running setup.py install for docopt 05:07:37 INFO - Successfully installed blobuploader requests docopt 05:07:37 INFO - Cleaning up... 05:07:37 INFO - Return code: 0 05:07:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:07:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 0x15df030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18a0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189e3b0>, '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 0x189f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x189f740>, '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': 'df17445c3590ff7897617a0e00000225-1468238827.513368-827136256', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:07:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:07:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:07:37 INFO - Using env: {'DISPLAY': ':0', 05:07:37 INFO - 'HOME': '/home/cltbld', 05:07:37 INFO - 'LANG': 'en_US.UTF-8', 05:07:37 INFO - 'LANGUAGE': 'en_US:en', 05:07:37 INFO - 'LOGNAME': 'cltbld', 05:07:37 INFO - 'MAIL': '/var/mail/cltbld', 05:07:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:37 INFO - 'MOZ_NO_REMOTE': '1', 05:07:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:37 INFO - 'NO_EM_RESTART': '1', 05:07:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:37 INFO - 'PWD': '/builds/slave/test', 05:07:37 INFO - 'SHELL': '/bin/bash', 05:07:37 INFO - 'SHLVL': '1', 05:07:37 INFO - 'TERM': 'linux', 05:07:37 INFO - 'TMOUT': '86400', 05:07:37 INFO - 'USER': 'cltbld', 05:07:37 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468238827.513368-827136256', 05:07:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:37 INFO - '_': '/tools/buildbot/bin/python'} 05:07:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:07:37 INFO - Running setup.py (path:/tmp/pip-bWjstc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:07:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:07:37 INFO - Running setup.py (path:/tmp/pip-Vc7q89-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:07:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:07:37 INFO - Running setup.py (path:/tmp/pip-Dur2Iy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:07:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:07:37 INFO - Running setup.py (path:/tmp/pip-1ExyAW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:07:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:07:38 INFO - Running setup.py (path:/tmp/pip-q7mWCC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:07:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:07:38 INFO - Running setup.py (path:/tmp/pip-tOBZRr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:07:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:07:38 INFO - Running setup.py (path:/tmp/pip-QvIL4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:07:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:07:38 INFO - Running setup.py (path:/tmp/pip-6e7Fxt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:07:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:07:38 INFO - Running setup.py (path:/tmp/pip-qeh6g6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:07:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:07:38 INFO - Running setup.py (path:/tmp/pip-wmknJ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:07:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:07:38 INFO - Running setup.py (path:/tmp/pip-3BdGx2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:07:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:07:38 INFO - Running setup.py (path:/tmp/pip-F9dX24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:07:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:07:38 INFO - Running setup.py (path:/tmp/pip-oEaAqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:07:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:07:38 INFO - Running setup.py (path:/tmp/pip-vzoLT_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:07:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:07:38 INFO - Running setup.py (path:/tmp/pip-l5RUQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:07:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:07:38 INFO - Running setup.py (path:/tmp/pip-pvSqXG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:07:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:07:38 INFO - Running setup.py (path:/tmp/pip-xl9Q6H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:07:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:07:38 INFO - Running setup.py install for manifestparser 05:07:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:07:39 INFO - Running setup.py install for mozcrash 05:07:39 INFO - Running setup.py install for mozdebug 05:07:39 INFO - Running setup.py install for mozdevice 05:07:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:07:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:07:39 INFO - Running setup.py install for mozfile 05:07:39 INFO - Running setup.py install for mozhttpd 05:07:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:07:39 INFO - Running setup.py install for mozinfo 05:07:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:07:39 INFO - Running setup.py install for mozInstall 05:07:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:07:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:07:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:07:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:07:39 INFO - Running setup.py install for mozleak 05:07:39 INFO - Running setup.py install for mozlog 05:07:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:07:39 INFO - Running setup.py install for moznetwork 05:07:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:07:40 INFO - Running setup.py install for mozprocess 05:07:40 INFO - Running setup.py install for mozprofile 05:07:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:07:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:07:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:07:40 INFO - Running setup.py install for mozrunner 05:07:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:07:40 INFO - Running setup.py install for mozscreenshot 05:07:40 INFO - Running setup.py install for moztest 05:07:40 INFO - Running setup.py install for mozversion 05:07:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:07:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:07:40 INFO - Cleaning up... 05:07:40 INFO - Return code: 0 05:07:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:07:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x15df030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18a0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189e3b0>, '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 0x189f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x189f740>, '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': 'df17445c3590ff7897617a0e00000225-1468238827.513368-827136256', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:07:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:07:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:07:40 INFO - Using env: {'DISPLAY': ':0', 05:07:40 INFO - 'HOME': '/home/cltbld', 05:07:40 INFO - 'LANG': 'en_US.UTF-8', 05:07:40 INFO - 'LANGUAGE': 'en_US:en', 05:07:40 INFO - 'LOGNAME': 'cltbld', 05:07:40 INFO - 'MAIL': '/var/mail/cltbld', 05:07:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:40 INFO - 'MOZ_NO_REMOTE': '1', 05:07:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:40 INFO - 'NO_EM_RESTART': '1', 05:07:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:40 INFO - 'PWD': '/builds/slave/test', 05:07:40 INFO - 'SHELL': '/bin/bash', 05:07:40 INFO - 'SHLVL': '1', 05:07:40 INFO - 'TERM': 'linux', 05:07:40 INFO - 'TMOUT': '86400', 05:07:40 INFO - 'USER': 'cltbld', 05:07:40 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468238827.513368-827136256', 05:07:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:40 INFO - '_': '/tools/buildbot/bin/python'} 05:07:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:07:40 INFO - Running setup.py (path:/tmp/pip-vZTJ2r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:07:41 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:07:41 INFO - Running setup.py (path:/tmp/pip-7Ve7yp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:07:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:07:41 INFO - Running setup.py (path:/tmp/pip-hXizhx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:07:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:07:41 INFO - Running setup.py (path:/tmp/pip-7oFOor-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:07:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:07:41 INFO - Running setup.py (path:/tmp/pip-TcUuVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:07:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:07:41 INFO - Running setup.py (path:/tmp/pip-oNTlhV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:07:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:07:41 INFO - Running setup.py (path:/tmp/pip-UPyNdw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:07:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:07:41 INFO - Running setup.py (path:/tmp/pip-kzlp5u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:07:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:07:41 INFO - Running setup.py (path:/tmp/pip-ndfwuN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:07:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:07:41 INFO - Running setup.py (path:/tmp/pip-LIXffp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:07:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:07:41 INFO - Running setup.py (path:/tmp/pip-HUAdJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:07:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:07:41 INFO - Running setup.py (path:/tmp/pip-sqZQBw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:07:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:07:41 INFO - Running setup.py (path:/tmp/pip-akwlKH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:07:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:07:41 INFO - Running setup.py (path:/tmp/pip-gbHUSB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:07:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:07:41 INFO - Running setup.py (path:/tmp/pip-gvNGys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:07:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:07:42 INFO - Running setup.py (path:/tmp/pip-nOqc3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:07:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:07:42 INFO - Running setup.py (path:/tmp/pip-S_WOOz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:07:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:07:42 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:07:42 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:07:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:07:42 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:07:42 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:07:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:07:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:44 INFO - Downloading blessings-1.6.tar.gz 05:07:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:07:44 INFO - Installing collected packages: blessings 05:07:44 INFO - Running setup.py install for blessings 05:07:44 INFO - Successfully installed blessings 05:07:44 INFO - Cleaning up... 05:07:44 INFO - Return code: 0 05:07:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:07:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:07:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:07:44 INFO - Reading from file tmpfile_stdout 05:07:44 INFO - Current package versions: 05:07:44 INFO - argparse == 1.2.1 05:07:44 INFO - blessings == 1.6 05:07:44 INFO - blobuploader == 1.2.4 05:07:44 INFO - docopt == 0.6.1 05:07:44 INFO - functools32 == 3.2.3-2 05:07:44 INFO - jsonschema == 2.5.1 05:07:44 INFO - manifestparser == 1.1 05:07:44 INFO - mozInstall == 1.12 05:07:44 INFO - mozcrash == 0.17 05:07:44 INFO - mozdebug == 0.1 05:07:44 INFO - mozdevice == 0.48 05:07:44 INFO - mozfile == 1.2 05:07:44 INFO - mozhttpd == 0.7 05:07:44 INFO - mozinfo == 0.9 05:07:44 INFO - mozleak == 0.1 05:07:44 INFO - mozlog == 3.2 05:07:44 INFO - moznetwork == 0.27 05:07:44 INFO - mozprocess == 0.23 05:07:44 INFO - mozprofile == 0.28 05:07:44 INFO - mozrunner == 6.12 05:07:44 INFO - mozscreenshot == 0.1 05:07:44 INFO - mozsystemmonitor == 0.3 05:07:44 INFO - moztest == 0.7 05:07:44 INFO - mozversion == 1.4 05:07:44 INFO - psutil == 3.1.1 05:07:44 INFO - requests == 1.2.3 05:07:44 INFO - wsgiref == 0.1.2 05:07:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:07:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x15df030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18a0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189e3b0>, '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 0x189f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x189f740>, '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': 'df17445c3590ff7897617a0e00000225-1468238827.513368-827136256', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:07:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:07:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:07:44 INFO - Using env: {'DISPLAY': ':0', 05:07:44 INFO - 'HOME': '/home/cltbld', 05:07:44 INFO - 'LANG': 'en_US.UTF-8', 05:07:44 INFO - 'LANGUAGE': 'en_US:en', 05:07:44 INFO - 'LOGNAME': 'cltbld', 05:07:44 INFO - 'MAIL': '/var/mail/cltbld', 05:07:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:44 INFO - 'MOZ_NO_REMOTE': '1', 05:07:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:44 INFO - 'NO_EM_RESTART': '1', 05:07:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:44 INFO - 'PWD': '/builds/slave/test', 05:07:44 INFO - 'SHELL': '/bin/bash', 05:07:44 INFO - 'SHLVL': '1', 05:07:44 INFO - 'TERM': 'linux', 05:07:44 INFO - 'TMOUT': '86400', 05:07:44 INFO - 'USER': 'cltbld', 05:07:44 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468238827.513368-827136256', 05:07:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:44 INFO - '_': '/tools/buildbot/bin/python'} 05:07:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:07:44 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 2)) 05:07:44 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 3)) 05:07:44 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 4)) 05:07:44 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 5)) 05:07:44 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 6)) 05:07:44 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 7)) 05:07:44 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 8)) 05:07:44 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 9)) 05:07:44 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.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:07:44 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 4)) 05:07:44 INFO - Cleaning up... 05:07:44 INFO - Return code: 0 05:07:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:07:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15df030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18a0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189e3b0>, '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 0x189f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x189f740>, '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': 'df17445c3590ff7897617a0e00000225-1468238827.513368-827136256', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:07:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'jsonschema'] in /builds/slave/test/build 05:07:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 jsonschema 05:07:44 INFO - Using env: {'DISPLAY': ':0', 05:07:44 INFO - 'HOME': '/home/cltbld', 05:07:44 INFO - 'LANG': 'en_US.UTF-8', 05:07:44 INFO - 'LANGUAGE': 'en_US:en', 05:07:44 INFO - 'LOGNAME': 'cltbld', 05:07:44 INFO - 'MAIL': '/var/mail/cltbld', 05:07:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:44 INFO - 'MOZ_NO_REMOTE': '1', 05:07:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:44 INFO - 'NO_EM_RESTART': '1', 05:07:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:44 INFO - 'PWD': '/builds/slave/test', 05:07:44 INFO - 'SHELL': '/bin/bash', 05:07:44 INFO - 'SHLVL': '1', 05:07:44 INFO - 'TERM': 'linux', 05:07:44 INFO - 'TMOUT': '86400', 05:07:44 INFO - 'USER': 'cltbld', 05:07:44 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468238827.513368-827136256', 05:07:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:44 INFO - '_': '/tools/buildbot/bin/python'} 05:07:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:07:44 INFO - Cleaning up... 05:07:44 INFO - Return code: 0 05:07:44 INFO - Running post-action listener: _resource_record_post_action 05:07:44 INFO - Running post-action listener: _start_resource_monitoring 05:07:44 INFO - Starting resource monitoring. 05:07:44 INFO - ##### 05:07:44 INFO - ##### Finished create-virtualenv step (success) 05:07:44 INFO - ##### 05:07:44 INFO - ##### 05:07:44 INFO - ##### Running install step. 05:07:44 INFO - ##### 05:07:44 INFO - Running pre-action listener: _resource_record_pre_action 05:07:44 INFO - Running main action method: install 05:07:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:07:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:07:45 INFO - Reading from file tmpfile_stdout 05:07:45 INFO - Detecting whether we're running mozinstall >=1.0... 05:07:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:07:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:07:45 INFO - Reading from file tmpfile_stdout 05:07:45 INFO - Output received: 05:07:45 INFO - Usage: mozinstall [options] installer 05:07:45 INFO - Options: 05:07:45 INFO - -h, --help show this help message and exit 05:07:45 INFO - -d DEST, --destination=DEST 05:07:45 INFO - Directory to install application into. [default: 05:07:45 INFO - "/builds/slave/test"] 05:07:45 INFO - --app=APP Application being installed. [default: firefox] 05:07:45 INFO - mkdir: /builds/slave/test/build/application 05:07:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:07:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:08:03 INFO - Reading from file tmpfile_stdout 05:08:03 INFO - Output received: 05:08:03 INFO - /builds/slave/test/build/application/firefox/firefox 05:08:03 INFO - Running post-action listener: _resource_record_post_action 05:08:03 INFO - ##### 05:08:03 INFO - ##### Finished install step (success) 05:08:03 INFO - ##### 05:08:03 INFO - ##### 05:08:03 INFO - ##### Running run-tests step. 05:08:03 INFO - ##### 05:08:03 INFO - Running pre-action listener: _resource_record_pre_action 05:08:03 INFO - Running main action method: run_tests 05:08:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:08:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:08:03 INFO - Python 2.7.3 05:08:03 INFO - Return code: 0 05:08:03 INFO - grabbing minidump binary from tooltool 05:08:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:03 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189e3b0>, '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 0x189f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x189f740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:08:03 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:08:03 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:08:03 INFO - Calling ['/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'] with output_timeout 600 05:08:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:08:03 INFO - Return code: 0 05:08:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:08:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:08:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:08:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:08:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:08:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/coEJbLhqTci38c6RWN6rzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:08:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/coEJbLhqTci38c6RWN6rzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:08:03 INFO - Using env: {'DISPLAY': ':0', 05:08:03 INFO - 'HOME': '/home/cltbld', 05:08:03 INFO - 'LANG': 'en_US.UTF-8', 05:08:03 INFO - 'LANGUAGE': 'en_US:en', 05:08:03 INFO - 'LOGNAME': 'cltbld', 05:08:03 INFO - 'MAIL': '/var/mail/cltbld', 05:08:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:08:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:08:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:03 INFO - 'MOZ_NO_REMOTE': '1', 05:08:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:08:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:03 INFO - 'NO_EM_RESTART': '1', 05:08:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:03 INFO - 'PWD': '/builds/slave/test', 05:08:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:08:03 INFO - 'SHELL': '/bin/bash', 05:08:03 INFO - 'SHLVL': '1', 05:08:03 INFO - 'TERM': 'linux', 05:08:03 INFO - 'TMOUT': '86400', 05:08:03 INFO - 'USER': 'cltbld', 05:08:03 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468238827.513368-827136256', 05:08:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:03 INFO - '_': '/tools/buildbot/bin/python'} 05:08:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/coEJbLhqTci38c6RWN6rzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:08:03 INFO - mozversion application_buildid: 20160711021319 05:08:03 INFO - mozversion application_changeset: 0136b1e24160b1daf36846fb5aaf4a52e6f6d457 05:08:03 INFO - mozversion application_display_name: Nightly 05:08:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:08:03 INFO - mozversion application_name: Firefox 05:08:03 INFO - mozversion application_remotingname: firefox 05:08:03 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:08:03 INFO - mozversion application_vendor: Mozilla 05:08:03 INFO - mozversion application_version: 50.0a1 05:08:03 INFO - mozversion platform_buildid: 20160711021319 05:08:03 INFO - mozversion platform_changeset: 0136b1e24160b1daf36846fb5aaf4a52e6f6d457 05:08:03 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:08:03 INFO - mozversion platform_version: 50.0a1 05:08:03 INFO - using testdate: 1468238883 05:08:03 INFO - actual date: 1468238883 05:08:03 INFO - starting webserver on 'localhost:44450' 05:08:03 INFO - SUITE-START | Running 2 tests 05:08:03 INFO - TEST-START | dromaeo_css 05:08:03 INFO - operating with platform_type : linux_ 05:08:03 INFO - Initialising browser for dromaeo_css test... 05:08:04 INFO - TEST-INFO | started process 8395 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAS63jW/profile http://localhost:44450/getInfo.html) 05:08:09 INFO - PROCESS | 8395 | __metrics Screen width/height:1600/1200 05:08:09 INFO - PROCESS | 8395 | colorDepth:24 05:08:09 INFO - PROCESS | 8395 | Browser inner width/height: 1024/697 05:08:09 INFO - PROCESS | 8395 | __metrics 05:08:09 ERROR - PROCESS | 8395 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 05:08:10 INFO - TEST-INFO | 8395: exit 0 05:08:10 INFO - Browser initialized. 05:08:10 INFO - Running cycle 1/1 for dromaeo_css test... 05:08:10 INFO - TEST-INFO | started process 8515 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAS63jW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:08:22 INFO - PROCESS | 8515 | RSS: Main: 167469056 05:08:22 INFO - PROCESS | 8515 | 05:09:12 INFO - PROCESS | 8515 | 1468238952236 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:11:20 INFO - PROCESS | 8515 | Cycle 1(1): loaded http://localhost:44450/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44450/tests/dromaeo/cssquery-ext.html) 05:11:21 INFO - PROCESS | 8515 | RSS: Main: 172482560 05:11:21 INFO - PROCESS | 8515 | 05:14:23 INFO - PROCESS | 8515 | Cycle 1(1): loaded http://localhost:44450/tests/dromaeo/cssquery-ext.html (next: http://localhost:44450/tests/dromaeo/cssquery-jquery.html) 05:14:23 INFO - PROCESS | 8515 | RSS: Main: 168673280 05:14:23 INFO - PROCESS | 8515 | 05:17:25 INFO - PROCESS | 8515 | Cycle 1(1): loaded http://localhost:44450/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44450/tests/dromaeo/cssquery-mootools.html) 05:17:26 INFO - PROCESS | 8515 | RSS: Main: 171233280 05:17:26 INFO - PROCESS | 8515 | 05:20:28 INFO - PROCESS | 8515 | Cycle 1(1): loaded http://localhost:44450/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44450/tests/dromaeo/cssquery-prototype.html) 05:20:28 INFO - PROCESS | 8515 | RSS: Main: 166453248 05:20:28 INFO - PROCESS | 8515 | 05:23:31 INFO - PROCESS | 8515 | Cycle 1(1): loaded http://localhost:44450/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44450/tests/dromaeo/cssquery-yui.html) 05:23:31 INFO - PROCESS | 8515 | RSS: Main: 169369600 05:23:31 INFO - PROCESS | 8515 | 05:26:34 INFO - PROCESS | 8515 | Cycle 1(1): loaded http://localhost:44450/tests/dromaeo/cssquery-yui.html (next: http://localhost:44450/tests/dromaeo/cssquery-dojo.html) 05:26:34 INFO - PROCESS | 8515 | RSS: Main: 170151936 05:26:34 INFO - PROCESS | 8515 | 05:26:34 INFO - PROCESS | 8515 | __start_tp_report 05:26:34 INFO - PROCESS | 8515 | _x_x_mozilla_page_load 05:26:34 INFO - PROCESS | 8515 | _x_x_mozilla_page_load_details 05:26:34 INFO - PROCESS | 8515 | |i|pagename|runs| 05:26:34 INFO - PROCESS | 8515 | |0;dojo.html;3030.3636236390357;3050.8016978896385;3105.5807465992093;3108.844557772111;3117.4856148735444;5453.400125986143;5489.258950041738;5497.01053810314;5583.972080139603;5598.412166722496;5343.412224655285;5479.6164268501225;5504.4495550444935;5578.497935185833;5663.461971112738;5012.874678133057;5043.899122017558;5095.6942583444925;5127.461616530267;5169.069567477872;659.9011679614566;4895.779689913962;4962.60299176065;4992.650514463989;5084.974575127119;4985.675931064469;5007.674501157413;5031.6729412588065;5035.169197082495;5035.748212589356;5034.823781167642;5036.395632524084;5043.092243396187;5044.672096313765;5064.18972964324;4962.255661650745;4993.201087825931;5006.023825354021;5009.799608015675;5020.723860187688;5460.972695136538;5464.180372944051;5488.313960754906;5488.4785945335125;5529.225908372831;5641.915371269434;5864.853378665525;5887.35239123696;5905.763769449217;5907.852303692399;5936.1392598073035;5992.520598352165;6015;6018.037114061729;6069.2716873975405;5571.804986825482;5577.414371490976;5577.553795696375;5580.246666699984;5580.414056524047;5831.300243970751;5989.880202395928;6028.5478589106;6130.233720784902;6141.140240366352;5778.971105144447;5782.566307526952;5785.103308987113;5788.594798364158;5789.131630255411;5931;5934.584579079509;5944.940550594439;5950.761969521257;5967.283925928917;5819.709014549256;5822.650640961556;5842.152887831241;5869.325027621793;5900.852478688067;5832.24180856486;5866.7653293868625;5875.559333049953;5877.94122058774;5918.940810591839;4350.173467041315;4467.218236808546;4476.574725401082;4501.662375321864;4558.270676691714;3919.941200881989;3944.6252606002386;3980.2238563480423;3990.6009399059863;3996.2407142642805;5619.606627536115;5699.287589051369;5707.3721890592005;5721.998650236192;5746.224259724967;5944.64332140073;5969.910451343233;5970.910436343458;5971;5977.491913187341;5419.05166595852;5579.8884022320135;5631.8592035199445;5693.487586117187;5696.686682232434;5060.949390506122;5083.983203359343;5107.157319042316;5110.897782044338;5114.232865070195;5940.970295148497;6142.477889379453;6143.078538219303;6151.5386346024225;6167.814965551041;5757.625754325955;5853.385394533512;5862.003459411995;5901.852453688693;5941.257342832146;6139.2325959255095;6140.293866205265;6168.660723660242;6169.753209871555;6171.9691401544505;5777.94222057774;5822.73797679097;5835.79574714883;5837.5329973601165;5862.208601838697;5730.828075157752;5809.767609295581;5835.533157347317;5878.735456904535;5948.434898684618;5696.914546281892;5750.281214848144;5757.193992841089;5768;5772.7690892363835;5748.597598168255;5753.654780713171;5757.107648314518;5775.364709881994;5777.537796976316;5512.972435137799;5655.406182350794;5708.828735137952;5767.711614419346;5773.509251713652;5827.76688932438;5836.766529338779;5840.123981402823;5868.413158684098;5894.498967587803;5495.752691128989;5700.401457847032;5737.368889422077;5739.684317362585;5741.45456181662 05:26:34 INFO - PROCESS | 8515 | |1;ext.html;562.067378816591;584.941505849415;600.9759609615616;617.4535536050597;636.4240362471965;38323.80838095809;42348.78825605875;42737.14525709484;42795.78602106993;42958.496452624124;42536;42874.14251714964;43276;43330.35004474936;43481;8811.471311721285;8942.86585701215;8957.910420895772;8972.59623316949;8972.775680607972;9009.099090091004;9071.002189759121;9076.773080673003;9078.455292682427;9086.77283067922;9024.639014439415;9123.315751318645;9124.40691355063;9133.497657628828;9138.086191380842;9026.819463610724;9066.54667266634;9066.909330906738;9083.818323633523;9092.40899341544;8900.37697361185;8904.821903561893;8976.506292153928;8985;9005.459672419676;41260.587394126276;41564.79217603923;41611.37582936259;41690.37464438036;41734.791326043174;3603.045193023851;3608.1200003955128;3686.8340924658455;3691.151035261878;3705.4256590228556;33687.4946875797;33779.32441351184;34193.829030854686;34208.65791342079;34342.48486272708;4441.844535441244;4458.08609235106;4535.478419981711;4557.270836666151;4573.336866154422;251384;260061;260570;261231;262919.68540157366;34264.972050838514;35038.299234015176;35160.82419587886;56881;57189.71405143031;36669.816650916575;36798;36802.63197368046;36831.4475282871;36894.077648058475;14507.854921450651;14529.128252304896;14665.706685866224;14669.413223471154;14706.926465367605;13181;13197;13238.602841914759;13276.20342779417;13283.867161328457;8374.995000599967;8391.8670979417;8427.452215605967;8432.74701758936;8451.492910425393;3261.0705948804953;3288.2272665923488;3297.86808527661;3309.93380132396;3367.74741894354;1001.8246806808779;1039.564240186177;1052.3054783842626;1112.204773586873;1113.204059097749;32415;32618.347633047208;32664;32998.3400331992;33546.3290734184;1067.8558394616628;1114.57089020726;1123.1744667669257;1139.4758411130972;1193.0574845871665;16830.831691682928;17225.65548689019;17259.827401726074;17397.217125229396;17555.385561505285;570970;572128;572494;576342;577046;59129;59264;59466.40533594609;59878.70060649669;59897;1313.3039489070807;1359.4766015084067;1370.4723681382739;1377.758892193862;1380.6617378742274;31111.37777244397;31790.523142152422;32340;32777.50833737448;33152.1711957203;58512.4148758507;59584.70207648934;59586.40413595809;59595.70202148962;59770.701146493986;544180;546466;548234;549545;552184;28288.43423131567;28979.56530652;28980.130596082152;43517.564824352616;44474;47678;48157.27764083471;48974.26538601995;49661.25508117309;50173.24740128828;41415.58584414118;41764.582354177284;41888.790556047024;42138.57861421347;43290.56709432865;41542.58457415508;41620.37569436521;42010.36984445174;42595.787021064694;43608;41457.37813932854;41977.580224197365;42347.3647895288;42452.787736061124;44873.32690009718;33429.331413372085;36854;37280;39214;39540.60459395369;28761.85619071975;28948.42103157967;29142.125736227947;29308.70691293145;29325.26686832846 05:26:34 INFO - PROCESS | 8515 | |2;jquery.html;380.12462940323377;380.15036393660165;393.19983832900044;396.32624538284915;412.6430637498565;15274.465393711222;18918.716219256705;19990.50023749407;20819.27132550361;20848.47878803031;19207.711884321747;19483.220671173138;20156.294529691426;20330.39008829734;20409.591808163867;5613.298337707776;5710.628809127394;5853;5856.267966504187;5871.941280587203;5736.799212027579;5742.425757424266;5745.2818397700285;5757.222774925373;5801.593888427812;5638.915416268759;5746.741396637161;5768.567357448208;5769.221155144044;5808.680522571257;5687.943120568782;5741.110127930177;5747.166660834177;5769.5672824538115;5780.739866706008;5047.924281135749;5146;5163.561097306733;5176.715280659562;5196.792128314863;23983.640245396335;24157.516849663083;24533.38666533351;24703.62944555833;25132.246032619052;2550.553653110698;2597.545429549821;2633.789296856266;2923.108451922163;3206.6312374076815;10481.947590262;10998.615048473264;12623.495060197582;13821.723565528633;15264.236788160548;1941.631090092878;1968.7046942958527;1986.3941497843152;2098.0768461876723;2123.3205374280237;50872.491275087144;51073.489265107244;51223;52099.47900520984;79914.60042699808;11185.66443006711;11306.773864522664;11413.144014198802;11455.942720286512;11671.88328116725;12019.519219231308;12704.110712250238;12758.872411275768;15897.205139742966;15988.840111598967;7847.764567062883;7956.880646790303;8145.185481451926;8228.30059444942;8340.124286949784;8260.339172866277;8368;8463.74608761738;8510.148985101441;8572.27135693473;4107.876763697094;4141.855035073758;4172.520160181557;4202.642775364128;4271.594198551133;1970.9704354434696;1982.9504262393268;2012.9496762581052;2030.9796902031087;2037.1443993522755;945.7588314979636;957.4159762544842;975.1077763846001;978.9265805064649;1007.2093406675724;16836;19720.30978915731;20067.29764458237;20545.69181462279;20619.793802062086;977.7653363192925;981.4062492192121;986.6004268271362;988.229181238635;1003.0871906565137;10938.070264027647;11017.355834599639;11212.66362009141;11254.887451125383;11275.943620281847;451004;452929;456401;472378;475867;99765.50117249512;100315.49842250741;101681;101786;104303;963.4700914496999;974.91713204377;992.5136683025265;995.1193194023341;999.4053538144792;16221.35114595403;17701;17885.95215806536;17988.460346189637;18074.277028918696;31871;34686.47970280498;41918.790406047774;45405.77297113493;46778.53221467742;60589.394106058375;61232.69383653053;61371.69314153401;61662.383376165664;62470.06294905671;8494.490330580185;8593.8710919335;8712.956435217784;8822.823543529223;8949.552522373986;13310.267935263653;14245.35895884667;14667.706645867236;15051.548453546411;15140.864435167186;12350.567730129402;12383.257004579755;12724.300163490727;13172.802407963696;13195.142315749446;12492.937535312265;12576.30830304342;12824.615261542169;12835.294058826854;13045.804312935124;12547.372631368213;13113.27876966776;13120.737585248433;13161.802572961606;13172.670683232996;9067.773305667148;9089.454632722058;9179.862302065341;9237.07629237071;9312.906870931203;9476.384035037701;12407.565735199225;12804.359782011048;12843;13105.2136871788 05:26:34 INFO - PROCESS | 8515 | |3;mootools.html;1496.1621491964497;1530.18899983009;1691.9746203806944;1799.7390378395125;1830.4508647405783;7471.850562988737;8700.260477859381;8793.252573531257;9377.578008989594;9459.858102128457;8910.50992195429;9055.728328150166;9150.86273705895;9162.31282653802;9164.129407706258;2319.0723710515845;2376.5246950609862;2380.0241900820665;2389.0443822470975;2392.95214095718;2276.8633881967053;2292.541491701658;2340.8361414700976;2342.9414264643433;2343.8710870902178;2313.6298192289237;2324.5931961906686;2331.9300420987397;2352.4001379648166;2352.8588284702887;2229.799318061366;2233.129079658934;2249.5725812095648;2250.122452243618;2250.819934405252;2248.067052173346;2283.2237039406514;2301.689271948282;2303.4126297794123;2309.734380546225;9183.03578124294;9221.769455763593;9242.81514369709;9251.676191333338;9299.48852813095;5221.973890130563;5300.0459917214885;5326.094563924142;5346.893062138774;5355.2770375999135;3233.417984762742;3361.9495707564406;3387.9661203388146;3446.5691788526433;3465.5321531593163;1084.9367619732707;1091.328832767842;1096.4956120184725;1112.104755671684;1116.7152376144031;12813.423395947204;12929.48282068716;12998;13027.348632568428;13076.019298552646;4615.746133962664;4649.442066951988;4765.237561990065;4801.759912004386;4825.30033145192;10917.344959302467;10921.39932303715;10929.726756831144;10933.56265749377;10938.890611093788;5447.536959358499;5460.781568737286;5460.945390546044;5486.61593688438;5488.725563721878;4274.059706864485;4855.587275081587;5008.57427118699;5022.447530771612;5025.824096156617;3979.741316814456;4042.413849991735;4137.338025915839;4160.750354978711;4179.393987871802;1284.6724085358173;1313.074282630743;1315.2700251360395;1317.1372750848209;1326.2838067443665;996.9202463803024;1020.8009438159636;1027.7584767579613;1049.7585555322166;1051.500537244818;6035.969820150871;6095.1771510845465;6132.78535251273;6188.597741146811;6222.222222222223;443.31065193624227;446.0387864152756;448.6209153265485;450.6259804362371;454.82943896038984;4305.332673435622;4320.157569274024;4372.693911426233;4385.583369579885;4391.736495810262;10790.460476976119;11043.503042362952;11063.059639930696;11153.832692509619;11225.607103751492;10847.349159050482;10948.945255273673;10988.890111098786;11134.33194008362;11193.16051296156;8318.584070796436;8328.791780205422;8345.165483451729;8443.95778021106;8455.915440845512;6003.219581454383;6033.849153771191;6069.2110025696375;6221.502279817694;6224.595401298901;9947.502624868872;9986.60053597848;10307.845382319121;10318.638847640297;10362.533685983997;10346.32748871321;10348.793024139324;10590.735231619272;10604.840927385942;10627.415492148006;6898.413634841095;7736.574488402966;7779.805504862424;7990.960045199737;8000.199980001953;8798.780030499289;8893.510856902933;9000.684976025808;9003.054679258583;9005.729828105168;7441.144268409203;7573.166951635206;7754.495957762728;7772.883406749016;8078.596070196584;7497.10034795828;7559.735409260649;7669.693212271447;7712.691492340244;7754.534727916343;6737.225219099866;6806.149231346082;6832.521723479507;6861.828454288683;6899.413549848319;5307.150855863043;5397.8110766123;5519.227308176778;5523.28197334344;5553.139263414178;5279.788808447619;5379.973100134631;5403.378611459732;5439.809606663748;5470.781168753205 05:26:34 INFO - PROCESS | 8515 | |4;prototype.html;327.3142765905429;333.2551746845799;339.123366098635;341.23903694760685;345.0975698548297;5437.102878025131;5569.526590239824;5691.288588926384;5703.543716502681;5744.3968383319725;5591.916121258185;5605.607607467479;5608.46719561642;5620.634658747179;5668.68822214778;4368.97815510922;4372.016296333315;4372.622623873485;4382;4388.210122178007;4106.630403263705;4341.565843415665;4354.303311470149;4381.904523869032;4410.2943529035365;4289.5924887135825;4296.8281268749215;4317.11499142675;4320.28715261983;4325.961769175391;4332.436783218193;4335.263005289093;4335.501417336984;4351.042770590465;4397.824087036514;3776.8866933992026;3822.0062783676444;3852.171783066626;3870.6516413522636;3873.1091848874917;5418.810341638064;5469.617126801126;5479.342478902558;5501.642393244426;5551.528120109796;4973.239851882204;4985.626078044161;5003.124453220672;5013.373328333958;5024.171011783052;5778.3643799182055;5858.531317494633;5891.823245302648;5892.175095486636;5931.169636250928;4168.437260969791;4173.332266837322;4188.4136220929095;4195.964956995855;4202.3696445533105;6108.877822443571;6138.294096178952;6144.5698801083945;6155.353687862755;6162.22972128484;4063.593640635972;4271.743695378287;4304.91390172201;4309.870703878889;4310.353446982915;4332.610065094157;4339.869803905888;4354.804033818423;4362.6509879210225;4368.497622773421;5019.222020586815;5019.322391477177;5019.874503137377;5039.82360617384;5043.142665746832;5772.797952071657;5894.762099958971;5932.169496270526;5988.970055149696;5999.5800293979;1481.2297605245212;1498.400639744111;1498.5279636914338;1499.9025063371064;1509.9169545675093;933.2315262577378;955.5365647660878;955.6320816485703;967.4292167620997;969.4183489906;5088;5108.846734597968;5127.590152548513;5131.281020858054;5189.896202075937;5301.204819277139;5306.673331667083;5317.750328672759;5328.946710532845;5377.7733359983695;5120.516549473502;5154.92267615986;5158.3552055993005;5358.544523715528;5876.7355469004;3213.7268332191557;3229.54786329914;3236.207129253348;3255.9837200813845;3257.250832308535;6124.295705993779;6337.334579869047;6352.745890164434;6358.459530939922;6378.968105159444;6177.62934223948;6180.567360284737;6185.721642526097;6195.876082478415;6196.10156527301;6306.905396419057;6326;6368.235811702532;6386;6390.329015453403;5845;6071.453569178795;6077.693295941393;6078.7264573093435;6091.664958427329;5957.463828255478;5995.790147344822;5997.820065398045;6014.428629280212;6024.427679370453;5704.971475142598;6281.434670879643;6319.873602528016;6332.905006424815;6355.680176735551;4182.309918863353;4205.1379467208535;4217.578242175758;4240.512341080692;4246.747209573122;6050.334463208956;6073.939260607514;6077.6353418795015;6108.786192483241;6125.203723515914;5698.54411647059;5868.911966320594;5892;5899.646021238739;5922.822315330547;5834.541364658835;5855.1602472801505;5859.882802344015;5881.264841894763;5907.91138132937;5533.557315414838;5805.187273781589;5808.767649293981;5828.271466066742;5861.325947515919;5925.762969481172;5927.303077099996;5961.225040744849;5982.670953097621;5999.5800293979;5876.3536011039605;5884.382139875423;5913.408659134052;5916.970415147896;5952.910706339495 05:26:34 INFO - PROCESS | 8515 | |5;yui.html;753.9736109236178;754.4718696912159;792.6116203060502;832.5379414424993;855.4610595324946;15156.242187890603;16353.754693679604;16442.177891105443;16470.67058658826;16475.50573482796;14882.627934301649;15046.849531504682;15063.77404338933;15097.77353339698;15132.546023619281;656.5010591950129;771.7607541662074;795.4193438789687;814.3810703865075;814.7840822182127;805.3919290935336;809.8663720486113;815.0911733417256;816.6325153680867;818.3902992270766;855.4525103933456;856.2593356746431;858.0818524179131;858.4977787994;861.8017855893148;847.0724556610533;851.0680804519042;853.3770347646191;853.9274161696263;854.5599016506474;623.7130919776909;624.1386886097202;626.5394934722975;627.3036929008797;629.2291942370605;14381.424743010268;14521.636959076002;14527.564173074825;14553;14597;14365.425382984668;14558.199299038548;15294.082355058732;15430;15780.210989450596;13506.797398039038;13671.86328136716;13718.38267277975;13741.450341986409;13786.724265514633;4620.768961551909;4641.512641172696;4652.092841895832;4736.265878788793;4848.781804818792;77532;79107.20892791114;79233.20766792315;80105.19894801035;80547;10686.14510839131;11032.503537340679;11445.198836081561;11492.367919764492;11793.823092653616;20910.37268881936;20958.580828383347;21009;21030.684539731916;21089.261875834578;8863.423877448075;8983.371164018456;9027.729168124966;9278.582463789146;9360.672376466791;5059.392872855281;5076.086304465158;5115.283860259567;5138.897222055538;5235.554977826928;3340.1148695595684;3430.485427185942;3440.1571614954496;3446.827658617059;3460.740444466675;601.7232073246356;605.881853038662;608.6256951974592;609.2810483629271;616.4605969776445;658.58180055665;695.9630151074862;749.3031480722871;756.7389250708496;768.4582369429539;9549.809003819884;9557;10069.288221002447;10233.846492302622;10888.78222435547;741.4846681556267;754.5359603843597;766.2605585609801;772.8686123359042;790.4387884601997;4892;4909.263610458388;5112.565431938327;5115.7442127893455;5147.948520514822;69990.65004674943;84421;115370;115411;117259;100463;100851.49574252228;102773;105067;105430;79898.6005069971;86415;89413.29400295005;89614;90168;9488.478133702713;9512.668226448164;9823.477361009054;10045.899541004497;10219;51023.48976510188;52968.73515632397;53215.733921330146;53568;54544;76048.71447902563;77163.61418192873;79576;79670;79899.60050199712;13397.397117129947;13449.848024316063;13668;13709.383077761724;13722.176669399469;15500;15643;15699.607509812346;16472.25874835659;16477.67044659124;14000.859991399955;14066.507672231422;14383.19008206894;14469.710605788036;14483.78274325865;14776.704465910407;14796.778048329068;15068.171250581323;15107.093574385572;15130.319135638703;14068.577942661326;14168.83470849121;14222.217778022308;14386.42454301858;14443.205623690797;11998.880011199777;12043.337616431181;12054.276743395425;12120.939395302967;12171.817422738843;11749.823752643888;11843.644690659294;11853.466594003117;11976.520939162336;12037.578684745991 05:26:34 INFO - PROCESS | 8515 | __end_tp_report 05:26:34 INFO - PROCESS | 8515 | __start_cc_report 05:26:34 INFO - PROCESS | 8515 | _x_x_mozilla_cycle_collect,370 05:26:34 INFO - PROCESS | 8515 | __end_cc_report 05:26:34 INFO - PROCESS | 8515 | __startTimestamp1468239994675__endTimestamp 05:26:34 INFO - PROCESS | 8515 | 05:26:34 INFO - PROCESS | 8515 | ------- Summary: start ------- 05:26:34 INFO - PROCESS | 8515 | Number of tests: 6 05:26:34 INFO - PROCESS | 8515 | 05:26:34 INFO - PROCESS | 8515 | [#0] dojo.html Cycles:165 Average:5458.06 Median:5739.68 stddev:744.32 (13.0%) stddev-sans-first:721.83 05:26:34 INFO - PROCESS | 8515 | Values: 3030.4 3050.8 3105.6 3108.8 3117.5 5453.4 5489.3 5497.0 5584.0 5598.4 5343.4 5479.6 5504.4 5578.5 5663.5 5012.9 5043.9 5095.7 5127.5 5169.1 659.9 4895.8 4962.6 4992.7 5085.0 4985.7 5007.7 5031.7 5035.2 5035.7 5034.8 5036.4 5043.1 5044.7 5064.2 4962.3 4993.2 5006.0 5009.8 5020.7 5461.0 5464.2 5488.3 5488.5 5529.2 5641.9 5864.9 5887.4 5905.8 5907.9 5936.1 5992.5 6015.0 6018.0 6069.3 5571.8 5577.4 5577.6 5580.2 5580.4 5831.3 5989.9 6028.5 6130.2 6141.1 5779.0 5782.6 5785.1 5788.6 5789.1 5931.0 5934.6 5944.9 5950.8 5967.3 5819.7 5822.7 5842.2 5869.3 5900.9 5832.2 5866.8 5875.6 5877.9 5918.9 4350.2 4467.2 4476.6 4501.7 4558.3 3919.9 3944.6 3980.2 3990.6 3996.2 5619.6 5699.3 5707.4 5722.0 5746.2 5944.6 5969.9 5970.9 5971.0 5977.5 5419.1 5579.9 5631.9 5693.5 5696.7 5060.9 5084.0 5107.2 5110.9 5114.2 5941.0 6142.5 6143.1 6151.5 6167.8 5757.6 5853.4 5862.0 5901.9 5941.3 6139.2 6140.3 6168.7 6169.8 6172.0 5777.9 5822.7 5835.8 5837.5 5862.2 5730.8 5809.8 5835.5 5878.7 5948.4 5696.9 5750.3 5757.2 5768.0 5772.8 5748.6 5753.7 5757.1 5775.4 5777.5 5513.0 5655.4 5708.8 5767.7 5773.5 5827.8 5836.8 5840.1 5868.4 5894.5 5495.8 5700.4 5737.4 5739.7 5741.5 05:26:34 INFO - PROCESS | 8515 | 05:26:34 INFO - PROCESS | 8515 | [#1] ext.html Cycles:180 Average:61045.40 Median:41749.69 stddev:128846.00 (308.6%) stddev-sans-first:129127.42 05:26:34 INFO - PROCESS | 8515 | Values: 562.1 584.9 601.0 617.5 636.4 38323.8 42348.8 42737.1 42795.8 42958.5 42536.0 42874.1 43276.0 43330.4 43481.0 8811.5 8942.9 8957.9 8972.6 8972.8 9009.1 9071.0 9076.8 9078.5 9086.8 9024.6 9123.3 9124.4 9133.5 9138.1 9026.8 9066.5 9066.9 9083.8 9092.4 8900.4 8904.8 8976.5 8985.0 9005.5 41260.6 41564.8 41611.4 41690.4 41734.8 3603.0 3608.1 3686.8 3691.2 3705.4 33687.5 33779.3 34193.8 34208.7 34342.5 4441.8 4458.1 4535.5 4557.3 4573.3 251384.0 260061.0 260570.0 261231.0 262919.7 34265.0 35038.3 35160.8 56881.0 57189.7 36669.8 36798.0 36802.6 36831.4 36894.1 14507.9 14529.1 14665.7 14669.4 14706.9 13181.0 13197.0 13238.6 13276.2 13283.9 8375.0 8391.9 8427.5 8432.7 8451.5 3261.1 3288.2 3297.9 3309.9 3367.7 1001.8 1039.6 1052.3 1112.2 1113.2 32415.0 32618.3 32664.0 32998.3 33546.3 1067.9 1114.6 1123.2 1139.5 1193.1 16830.8 17225.7 17259.8 17397.2 17555.4 570970.0 572128.0 572494.0 576342.0 577046.0 59129.0 59264.0 59466.4 59878.7 59897.0 1313.3 1359.5 1370.5 1377.8 1380.7 31111.4 31790.5 32340.0 32777.5 33152.2 58512.4 59584.7 59586.4 59595.7 59770.7 544180.0 546466.0 548234.0 549545.0 552184.0 28288.4 28979.6 28980.1 43517.6 44474.0 47678.0 48157.3 48974.3 49661.3 50173.2 41415.6 41764.6 41888.8 42138.6 43290.6 41542.6 41620.4 42010.4 42595.8 43608.0 41457.4 41977.6 42347.4 42452.8 44873.3 33429.3 36854.0 37280.0 39214.0 39540.6 28761.9 28948.4 29142.1 29308.7 29325.3 05:26:34 INFO - PROCESS | 8515 | 05:26:34 INFO - PROCESS | 8515 | [#2] jquery.html Cycles:180 Average:28160.84 Median:18946.56 stddev:76203.30 (402.2%) stddev-sans-first:76388.52 05:26:34 INFO - PROCESS | 8515 | Values: 380.1 380.2 393.2 396.3 412.6 15274.5 18918.7 19990.5 20819.3 20848.5 19207.7 19483.2 20156.3 20330.4 20409.6 5613.3 5710.6 5853.0 5856.3 5871.9 5736.8 5742.4 5745.3 5757.2 5801.6 5638.9 5746.7 5768.6 5769.2 5808.7 5687.9 5741.1 5747.2 5769.6 5780.7 5047.9 5146.0 5163.6 5176.7 5196.8 23983.6 24157.5 24533.4 24703.6 25132.2 2550.6 2597.5 2633.8 2923.1 3206.6 10481.9 10998.6 12623.5 13821.7 15264.2 1941.6 1968.7 1986.4 2098.1 2123.3 50872.5 51073.5 51223.0 52099.5 79914.6 11185.7 11306.8 11413.1 11455.9 11671.9 12019.5 12704.1 12758.9 15897.2 15988.8 7847.8 7956.9 8145.2 8228.3 8340.1 8260.3 8368.0 8463.7 8510.1 8572.3 4107.9 4141.9 4172.5 4202.6 4271.6 1971.0 1983.0 2012.9 2031.0 2037.1 945.8 957.4 975.1 978.9 1007.2 16836.0 19720.3 20067.3 20545.7 20619.8 977.8 981.4 986.6 988.2 1003.1 10938.1 11017.4 11212.7 11254.9 11275.9 451004.0 452929.0 456401.0 472378.0 475867.0 99765.5 100315.5 101681.0 101786.0 104303.0 963.5 974.9 992.5 995.1 999.4 16221.4 17701.0 17886.0 17988.5 18074.3 31871.0 34686.5 41918.8 45405.8 46778.5 60589.4 61232.7 61371.7 61662.4 62470.1 8494.5 8593.9 8713.0 8822.8 8949.6 13310.3 14245.4 14667.7 15051.5 15140.9 12350.6 12383.3 12724.3 13172.8 13195.1 12492.9 12576.3 12824.6 12835.3 13045.8 12547.4 13113.3 13120.7 13161.8 13172.7 9067.8 9089.5 9179.9 9237.1 9312.9 9476.4 12407.6 12804.4 12843.0 13105.2 05:26:34 INFO - PROCESS | 8515 | 05:26:34 INFO - PROCESS | 8515 | [#3] mootools.html Cycles:180 Average:5926.16 Median:449.62 stddev:3422.12 (761.1%) stddev-sans-first:3415.53 05:26:34 INFO - PROCESS | 8515 | Values: 1496.2 1530.2 1692.0 1799.7 1830.5 7471.9 8700.3 8793.3 9377.6 9459.9 8910.5 9055.7 9150.9 9162.3 9164.1 2319.1 2376.5 2380.0 2389.0 2393.0 2276.9 2292.5 2340.8 2342.9 2343.9 2313.6 2324.6 2331.9 2352.4 2352.9 2229.8 2233.1 2249.6 2250.1 2250.8 2248.1 2283.2 2301.7 2303.4 2309.7 9183.0 9221.8 9242.8 9251.7 9299.5 5222.0 5300.0 5326.1 5346.9 5355.3 3233.4 3361.9 3388.0 3446.6 3465.5 1084.9 1091.3 1096.5 1112.1 1116.7 12813.4 12929.5 12998.0 13027.3 13076.0 4615.7 4649.4 4765.2 4801.8 4825.3 10917.3 10921.4 10929.7 10933.6 10938.9 5447.5 5460.8 5460.9 5486.6 5488.7 4274.1 4855.6 5008.6 5022.4 5025.8 3979.7 4042.4 4137.3 4160.8 4179.4 1284.7 1313.1 1315.3 1317.1 1326.3 996.9 1020.8 1027.8 1049.8 1051.5 6036.0 6095.2 6132.8 6188.6 6222.2 443.3 446.0 448.6 450.6 454.8 4305.3 4320.2 4372.7 4385.6 4391.7 10790.5 11043.5 11063.1 11153.8 11225.6 10847.3 10948.9 10988.9 11134.3 11193.2 8318.6 8328.8 8345.2 8444.0 8455.9 6003.2 6033.8 6069.2 6221.5 6224.6 9947.5 9986.6 10307.8 10318.6 10362.5 10346.3 10348.8 10590.7 10604.8 10627.4 6898.4 7736.6 7779.8 7991.0 8000.2 8798.8 8893.5 9000.7 9003.1 9005.7 7441.1 7573.2 7754.5 7772.9 8078.6 7497.1 7559.7 7669.7 7712.7 7754.5 6737.2 6806.1 6832.5 6861.8 6899.4 5307.2 5397.8 5519.2 5523.3 5553.1 5279.8 5380.0 5403.4 5439.8 5470.8 05:26:34 INFO - PROCESS | 8515 | 05:26:34 INFO - PROCESS | 8515 | [#4] prototype.html Cycles:180 Average:4923.40 Median:5560.53 stddev:1461.43 (26.3%) stddev-sans-first:1424.24 05:26:34 INFO - PROCESS | 8515 | Values: 327.3 333.3 339.1 341.2 345.1 5437.1 5569.5 5691.3 5703.5 5744.4 5591.9 5605.6 5608.5 5620.6 5668.7 4369.0 4372.0 4372.6 4382.0 4388.2 4106.6 4341.6 4354.3 4381.9 4410.3 4289.6 4296.8 4317.1 4320.3 4326.0 4332.4 4335.3 4335.5 4351.0 4397.8 3776.9 3822.0 3852.2 3870.7 3873.1 5418.8 5469.6 5479.3 5501.6 5551.5 4973.2 4985.6 5003.1 5013.4 5024.2 5778.4 5858.5 5891.8 5892.2 5931.2 4168.4 4173.3 4188.4 4196.0 4202.4 6108.9 6138.3 6144.6 6155.4 6162.2 4063.6 4271.7 4304.9 4309.9 4310.4 4332.6 4339.9 4354.8 4362.7 4368.5 5019.2 5019.3 5019.9 5039.8 5043.1 5772.8 5894.8 5932.2 5989.0 5999.6 1481.2 1498.4 1498.5 1499.9 1509.9 933.2 955.5 955.6 967.4 969.4 5088.0 5108.8 5127.6 5131.3 5189.9 5301.2 5306.7 5317.8 5328.9 5377.8 5120.5 5154.9 5158.4 5358.5 5876.7 3213.7 3229.5 3236.2 3256.0 3257.3 6124.3 6337.3 6352.7 6358.5 6379.0 6177.6 6180.6 6185.7 6195.9 6196.1 6306.9 6326.0 6368.2 6386.0 6390.3 5845.0 6071.5 6077.7 6078.7 6091.7 5957.5 5995.8 5997.8 6014.4 6024.4 5705.0 6281.4 6319.9 6332.9 6355.7 4182.3 4205.1 4217.6 4240.5 4246.7 6050.3 6073.9 6077.6 6108.8 6125.2 5698.5 5868.9 5892.0 5899.6 5922.8 5834.5 5855.2 5859.9 5881.3 5907.9 5533.6 5805.2 5808.8 5828.3 5861.3 5925.8 5927.3 5961.2 5982.7 5999.6 5876.4 5884.4 5913.4 5917.0 5952.9 05:26:34 INFO - PROCESS | 8515 | 05:26:34 INFO - PROCESS | 8515 | [#5] yui.html Cycles:180 Average:21090.67 Median:4694.18 stddev:29590.18 (630.4%) stddev-sans-first:29633.79 05:26:34 INFO - PROCESS | 8515 | Values: 754.0 754.5 792.6 832.5 855.5 15156.2 16353.8 16442.2 16470.7 16475.5 14882.6 15046.8 15063.8 15097.8 15132.5 656.5 771.8 795.4 814.4 814.8 805.4 809.9 815.1 816.6 818.4 855.5 856.3 858.1 858.5 861.8 847.1 851.1 853.4 853.9 854.6 623.7 624.1 626.5 627.3 629.2 14381.4 14521.6 14527.6 14553.0 14597.0 14365.4 14558.2 15294.1 15430.0 15780.2 13506.8 13671.9 13718.4 13741.5 13786.7 4620.8 4641.5 4652.1 4736.3 4848.8 77532.0 79107.2 79233.2 80105.2 80547.0 10686.1 11032.5 11445.2 11492.4 11793.8 20910.4 20958.6 21009.0 21030.7 21089.3 8863.4 8983.4 9027.7 9278.6 9360.7 5059.4 5076.1 5115.3 5138.9 5235.6 3340.1 3430.5 3440.2 3446.8 3460.7 601.7 605.9 608.6 609.3 616.5 658.6 696.0 749.3 756.7 768.5 9549.8 9557.0 10069.3 10233.8 10888.8 741.5 754.5 766.3 772.9 790.4 4892.0 4909.3 5112.6 5115.7 5147.9 69990.7 84421.0 115370.0 115411.0 117259.0 100463.0 100851.5 102773.0 105067.0 105430.0 79898.6 86415.0 89413.3 89614.0 90168.0 9488.5 9512.7 9823.5 10045.9 10219.0 51023.5 52968.7 53215.7 53568.0 54544.0 76048.7 77163.6 79576.0 79670.0 79899.6 13397.4 13449.8 13668.0 13709.4 13722.2 15500.0 15643.0 15699.6 16472.3 16477.7 14000.9 14066.5 14383.2 14469.7 14483.8 14776.7 14796.8 15068.2 15107.1 15130.3 14068.6 14168.8 14222.2 14386.4 14443.2 11998.9 12043.3 12054.3 12120.9 12171.8 11749.8 11843.6 11853.5 11976.5 12037.6 05:26:34 INFO - PROCESS | 8515 | -------- Summary: end -------- 05:26:34 INFO - PROCESS | 8515 | 05:26:35 INFO - TEST-INFO | 8515: exit 0 05:26:35 INFO - TEST-OK | dromaeo_css | took 1111487ms 05:26:35 INFO - TEST-START | kraken 05:26:35 INFO - operating with platform_type : linux_ 05:26:35 INFO - Initialising browser for kraken test... 05:26:35 INFO - TEST-INFO | started process 8766 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFgUi6g/profile http://localhost:44450/getInfo.html) 05:26:40 INFO - PROCESS | 8766 | __metrics Screen width/height:1600/1200 05:26:40 INFO - PROCESS | 8766 | colorDepth:24 05:26:40 INFO - PROCESS | 8766 | Browser inner width/height: 1024/697 05:26:40 INFO - PROCESS | 8766 | __metrics 05:26:41 ERROR - PROCESS | 8766 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 05:26:41 INFO - TEST-INFO | 8766: exit 0 05:26:41 INFO - Browser initialized. 05:26:41 INFO - Running cycle 1/1 for kraken test... 05:26:41 INFO - TEST-INFO | started process 8886 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFgUi6g/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:26:53 INFO - PROCESS | 8886 | RSS: Main: 168108032 05:26:53 INFO - PROCESS | 8886 | 05:26:56 INFO - PROCESS | 8886 | Cycle 1(1): loaded http://localhost:44450/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44450/tests/kraken/driver.html?testName=audio-beat-detection) 05:26:57 INFO - PROCESS | 8886 | RSS: Main: 173469696 05:26:57 INFO - PROCESS | 8886 | 05:26:59 INFO - PROCESS | 8886 | Cycle 1(1): loaded http://localhost:44450/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44450/tests/kraken/driver.html?testName=audio-dft) 05:27:00 INFO - PROCESS | 8886 | RSS: Main: 172322816 05:27:00 INFO - PROCESS | 8886 | 05:27:03 INFO - PROCESS | 8886 | Cycle 1(1): loaded http://localhost:44450/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44450/tests/kraken/driver.html?testName=audio-fft) 05:27:03 INFO - PROCESS | 8886 | RSS: Main: 166998016 05:27:03 INFO - PROCESS | 8886 | 05:27:06 INFO - PROCESS | 8886 | Cycle 1(1): loaded http://localhost:44450/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44450/tests/kraken/driver.html?testName=audio-oscillator) 05:27:06 INFO - PROCESS | 8886 | RSS: Main: 169091072 05:27:06 INFO - PROCESS | 8886 | 05:27:08 INFO - PROCESS | 8886 | Cycle 1(1): loaded http://localhost:44450/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44450/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:27:09 INFO - PROCESS | 8886 | RSS: Main: 168439808 05:27:09 INFO - PROCESS | 8886 | 05:27:12 INFO - PROCESS | 8886 | Cycle 1(1): loaded http://localhost:44450/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44450/tests/kraken/driver.html?testName=imaging-darkroom) 05:27:13 INFO - PROCESS | 8886 | RSS: Main: 169115648 05:27:13 INFO - PROCESS | 8886 | 05:27:16 INFO - PROCESS | 8886 | Cycle 1(1): loaded http://localhost:44450/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44450/tests/kraken/driver.html?testName=imaging-desaturate) 05:27:17 INFO - PROCESS | 8886 | RSS: Main: 166338560 05:27:17 INFO - PROCESS | 8886 | 05:27:20 INFO - PROCESS | 8886 | Cycle 1(1): loaded http://localhost:44450/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44450/tests/kraken/driver.html?testName=json-parse-financial) 05:27:20 INFO - PROCESS | 8886 | RSS: Main: 167395328 05:27:20 INFO - PROCESS | 8886 | 05:27:22 INFO - PROCESS | 8886 | Cycle 1(1): loaded http://localhost:44450/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44450/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:27:22 INFO - PROCESS | 8886 | RSS: Main: 168243200 05:27:22 INFO - PROCESS | 8886 | 05:27:24 INFO - PROCESS | 8886 | Cycle 1(1): loaded http://localhost:44450/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44450/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:27:25 INFO - PROCESS | 8886 | RSS: Main: 168185856 05:27:25 INFO - PROCESS | 8886 | 05:27:27 INFO - PROCESS | 8886 | Cycle 1(1): loaded http://localhost:44450/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44450/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:27:28 INFO - PROCESS | 8886 | RSS: Main: 168427520 05:27:28 INFO - PROCESS | 8886 | 05:27:30 INFO - PROCESS | 8886 | Cycle 1(1): loaded http://localhost:44450/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44450/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:27:31 INFO - PROCESS | 8886 | RSS: Main: 168710144 05:27:31 INFO - PROCESS | 8886 | 05:27:34 INFO - PROCESS | 8886 | Cycle 1(1): loaded http://localhost:44450/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44450/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:27:34 INFO - PROCESS | 8886 | RSS: Main: 168321024 05:27:34 INFO - PROCESS | 8886 | 05:27:36 INFO - PROCESS | 8886 | Cycle 1(1): loaded http://localhost:44450/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44450/tests/kraken/driver.html?testName=ai-astar) 05:27:36 INFO - PROCESS | 8886 | RSS: Main: 169598976 05:27:36 INFO - PROCESS | 8886 | 05:27:36 INFO - PROCESS | 8886 | __start_tp_report 05:27:36 INFO - PROCESS | 8886 | _x_x_mozilla_page_load 05:27:36 INFO - PROCESS | 8886 | _x_x_mozilla_page_load_details 05:27:36 INFO - PROCESS | 8886 | |i|pagename|runs| 05:27:36 INFO - PROCESS | 8886 | |0;ai-astar;102;111;106;110;112;112;112;110;112;111 05:27:36 INFO - PROCESS | 8886 | |1;audio-beat-detection;155;118;144;163;121;145;140;118;191;116 05:27:36 INFO - PROCESS | 8886 | |2;audio-dft;161;161;164;162;163;164;178;161;161;161 05:27:36 INFO - PROCESS | 8886 | |3;audio-fft;77;75;75;178;76;75;74;75;184;76 05:27:36 INFO - PROCESS | 8886 | |4;audio-oscillator;85;84;145;85;84;85;144;85;85;149 05:27:36 INFO - PROCESS | 8886 | |5;imaging-gaussian-blur;117;117;117;117;118;117;117;118;117;119 05:27:36 INFO - PROCESS | 8886 | |6;imaging-darkroom;147;147;146;147;149;147;146;148;147;148 05:27:36 INFO - PROCESS | 8886 | |7;imaging-desaturate;96;97;96;96;97;96;97;97;95;96 05:27:36 INFO - PROCESS | 8886 | |8;json-parse-financial;54;56;55;54;56;54;56;55;54;55 05:27:36 INFO - PROCESS | 8886 | |9;json-stringify-tinderbox;62;63;62;63;64;63;63;65;63;63 05:27:36 INFO - PROCESS | 8886 | |10;stanford-crypto-aes;77;76;79;78;78;77;77;78;82;77 05:27:36 INFO - PROCESS | 8886 | |11;stanford-crypto-ccm;131;138;123;128;135;120;123;126;167;133 05:27:36 INFO - PROCESS | 8886 | |12;stanford-crypto-pbkdf2;161;158;157;155;162;158;156;166;156;155 05:27:36 INFO - PROCESS | 8886 | |13;stanford-crypto-sha256-iterative;67;65;64;64;64;67;67;64;64;65 05:27:36 INFO - PROCESS | 8886 | __end_tp_report 05:27:36 INFO - PROCESS | 8886 | __start_cc_report 05:27:36 INFO - PROCESS | 8886 | _x_x_mozilla_cycle_collect,892 05:27:36 INFO - PROCESS | 8886 | __end_cc_report 05:27:36 INFO - PROCESS | 8886 | __startTimestamp1468240056588__endTimestamp 05:27:36 INFO - PROCESS | 8886 | 05:27:36 INFO - PROCESS | 8886 | ------- Summary: start ------- 05:27:36 INFO - PROCESS | 8886 | Number of tests: 14 05:27:36 INFO - PROCESS | 8886 | 05:27:36 INFO - PROCESS | 8886 | [#0] ai-astar Cycles:10 Average:109.80 Median:111.50 stddev:3.29 (3.0%) stddev-sans-first:1.94 05:27:36 INFO - PROCESS | 8886 | Values: 102.0 111.0 106.0 110.0 112.0 112.0 112.0 110.0 112.0 111.0 05:27:36 INFO - PROCESS | 8886 | 05:27:36 INFO - PROCESS | 8886 | [#1] audio-beat-detection Cycles:10 Average:141.10 Median:144.50 stddev:24.24 (16.8%) stddev-sans-first:25.18 05:27:36 INFO - PROCESS | 8886 | Values: 155.0 118.0 144.0 163.0 121.0 145.0 140.0 118.0 191.0 116.0 05:27:36 INFO - PROCESS | 8886 | 05:27:36 INFO - PROCESS | 8886 | [#2] audio-dft Cycles:10 Average:163.60 Median:162.50 stddev:5.21 (3.2%) stddev-sans-first:5.44 05:27:36 INFO - PROCESS | 8886 | Values: 161.0 161.0 164.0 162.0 163.0 164.0 178.0 161.0 161.0 161.0 05:27:36 INFO - PROCESS | 8886 | 05:27:36 INFO - PROCESS | 8886 | [#3] audio-fft Cycles:10 Average:96.50 Median:75.00 stddev:44.57 (59.4%) stddev-sans-first:46.71 05:27:36 INFO - PROCESS | 8886 | Values: 77.0 75.0 75.0 178.0 76.0 75.0 74.0 75.0 184.0 76.0 05:27:36 INFO - PROCESS | 8886 | 05:27:36 INFO - PROCESS | 8886 | [#4] audio-oscillator Cycles:10 Average:103.10 Median:85.00 stddev:29.63 (34.9%) stddev-sans-first:30.70 05:27:36 INFO - PROCESS | 8886 | Values: 85.0 84.0 145.0 85.0 84.0 85.0 144.0 85.0 85.0 149.0 05:27:36 INFO - PROCESS | 8886 | 05:27:36 INFO - PROCESS | 8886 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 05:27:36 INFO - PROCESS | 8886 | Values: 117.0 117.0 117.0 117.0 118.0 117.0 117.0 118.0 117.0 119.0 05:27:36 INFO - PROCESS | 8886 | 05:27:36 INFO - PROCESS | 8886 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 05:27:36 INFO - PROCESS | 8886 | Values: 147.0 147.0 146.0 147.0 149.0 147.0 146.0 148.0 147.0 148.0 05:27:36 INFO - PROCESS | 8886 | 05:27:36 INFO - PROCESS | 8886 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.50 stddev:0.67 (0.7%) stddev-sans-first:0.71 05:27:36 INFO - PROCESS | 8886 | Values: 96.0 97.0 96.0 96.0 97.0 96.0 97.0 97.0 95.0 96.0 05:27:36 INFO - PROCESS | 8886 | 05:27:36 INFO - PROCESS | 8886 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:55.00 stddev:0.88 (1.6%) stddev-sans-first:0.87 05:27:36 INFO - PROCESS | 8886 | Values: 54.0 56.0 55.0 54.0 56.0 54.0 56.0 55.0 54.0 55.0 05:27:36 INFO - PROCESS | 8886 | 05:27:36 INFO - PROCESS | 8886 | [#9] json-stringify-tinderbox Cycles:10 Average:63.10 Median:63.00 stddev:0.88 (1.4%) stddev-sans-first:0.83 05:27:36 INFO - PROCESS | 8886 | Values: 62.0 63.0 62.0 63.0 64.0 63.0 63.0 65.0 63.0 63.0 05:27:36 INFO - PROCESS | 8886 | 05:27:36 INFO - PROCESS | 8886 | [#10] stanford-crypto-aes Cycles:10 Average:77.90 Median:78.00 stddev:1.66 (2.1%) stddev-sans-first:1.73 05:27:36 INFO - PROCESS | 8886 | Values: 77.0 76.0 79.0 78.0 78.0 77.0 77.0 78.0 82.0 77.0 05:27:36 INFO - PROCESS | 8886 | 05:27:36 INFO - PROCESS | 8886 | [#11] stanford-crypto-ccm Cycles:10 Average:132.40 Median:132.00 stddev:13.45 (10.2%) stddev-sans-first:14.26 05:27:36 INFO - PROCESS | 8886 | Values: 131.0 138.0 123.0 128.0 135.0 120.0 123.0 126.0 167.0 133.0 05:27:36 INFO - PROCESS | 8886 | 05:27:36 INFO - PROCESS | 8886 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.40 Median:158.00 stddev:3.57 (2.3%) stddev-sans-first:3.66 05:27:36 INFO - PROCESS | 8886 | Values: 161.0 158.0 157.0 155.0 162.0 158.0 156.0 166.0 156.0 155.0 05:27:36 INFO - PROCESS | 8886 | 05:27:36 INFO - PROCESS | 8886 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.10 Median:65.00 stddev:1.37 (2.1%) stddev-sans-first:1.27 05:27:36 INFO - PROCESS | 8886 | Values: 67.0 65.0 64.0 64.0 64.0 67.0 67.0 64.0 64.0 65.0 05:27:36 INFO - PROCESS | 8886 | -------- Summary: end -------- 05:27:36 INFO - PROCESS | 8886 | 05:27:37 INFO - TEST-INFO | 8886: exit 0 05:27:37 INFO - TEST-OK | kraken | took 62132ms 05:27:37 INFO - SUITE-END | took 1173s 05:27:37 INFO - Completed test suite (00:19:33) 05:27:37 INFO - javascript benchmark 05:27:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7347.5096796228845, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3030.3636236390357, 3050.8016978896385, 3105.5807465992093, 3108.844557772111, 3117.4856148735444, 5453.400125986143, 5489.258950041738, 5497.01053810314, 5583.972080139603, 5598.412166722496, 5343.412224655285, 5479.6164268501225, 5504.4495550444935, 5578.497935185833, 5663.461971112738, 5012.874678133057, 5043.899122017558, 5095.6942583444925, 5127.461616530267, 5169.069567477872, 659.9011679614566, 4895.779689913962, 4962.60299176065, 4992.650514463989, 5084.974575127119, 4985.675931064469, 5007.674501157413, 5031.6729412588065, 5035.169197082495, 5035.748212589356, 5034.823781167642, 5036.395632524084, 5043.092243396187, 5044.672096313765, 5064.18972964324, 4962.255661650745, 4993.201087825931, 5006.023825354021, 5009.799608015675, 5020.723860187688, 5460.972695136538, 5464.180372944051, 5488.313960754906, 5488.4785945335125, 5529.225908372831, 5641.915371269434, 5864.853378665525, 5887.35239123696, 5905.763769449217, 5907.852303692399, 5936.1392598073035, 5992.520598352165, 6015.0, 6018.037114061729, 6069.2716873975405, 5571.804986825482, 5577.414371490976, 5577.553795696375, 5580.246666699984, 5580.414056524047, 5831.300243970751, 5989.880202395928, 6028.5478589106, 6130.233720784902, 6141.140240366352, 5778.971105144447, 5782.566307526952, 5785.103308987113, 5788.594798364158, 5789.131630255411, 5931.0, 5934.584579079509, 5944.940550594439, 5950.761969521257, 5967.283925928917, 5819.709014549256, 5822.650640961556, 5842.152887831241, 5869.325027621793, 5900.852478688067, 5832.24180856486, 5866.7653293868625, 5875.559333049953, 5877.94122058774, 5918.940810591839, 4350.173467041315, 4467.218236808546, 4476.574725401082, 4501.662375321864, 4558.270676691714, 3919.941200881989, 3944.6252606002386, 3980.2238563480423, 3990.6009399059863, 3996.2407142642805, 5619.606627536115, 5699.287589051369, 5707.3721890592005, 5721.998650236192, 5746.224259724967, 5944.64332140073, 5969.910451343233, 5970.910436343458, 5971.0, 5977.491913187341, 5419.05166595852, 5579.8884022320135, 5631.8592035199445, 5693.487586117187, 5696.686682232434, 5060.949390506122, 5083.983203359343, 5107.157319042316, 5110.897782044338, 5114.232865070195, 5940.970295148497, 6142.477889379453, 6143.078538219303, 6151.5386346024225, 6167.814965551041, 5757.625754325955, 5853.385394533512, 5862.003459411995, 5901.852453688693, 5941.257342832146, 6139.2325959255095, 6140.293866205265, 6168.660723660242, 6169.753209871555, 6171.9691401544505, 5777.94222057774, 5822.73797679097, 5835.79574714883, 5837.5329973601165, 5862.208601838697, 5730.828075157752, 5809.767609295581, 5835.533157347317, 5878.735456904535, 5948.434898684618, 5696.914546281892, 5750.281214848144, 5757.193992841089, 5768.0, 5772.7690892363835, 5748.597598168255, 5753.654780713171, 5757.107648314518, 5775.364709881994, 5777.537796976316, 5512.972435137799, 5655.406182350794, 5708.828735137952, 5767.711614419346, 5773.509251713652, 5827.76688932438, 5836.766529338779, 5840.123981402823, 5868.413158684098, 5894.498967587803, 5495.752691128989, 5700.401457847032, 5737.368889422077, 5739.684317362585, 5741.45456181662], "value": 5407.249875594308, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.067378816591, 584.941505849415, 600.9759609615616, 617.4535536050597, 636.4240362471965, 38323.80838095809, 42348.78825605875, 42737.14525709484, 42795.78602106993, 42958.496452624124, 42536.0, 42874.14251714964, 43276.0, 43330.35004474936, 43481.0, 8811.471311721285, 8942.86585701215, 8957.910420895772, 8972.59623316949, 8972.775680607972, 9009.099090091004, 9071.002189759121, 9076.773080673003, 9078.455292682427, 9086.77283067922, 9024.639014439415, 9123.315751318645, 9124.40691355063, 9133.497657628828, 9138.086191380842, 9026.819463610724, 9066.54667266634, 9066.909330906738, 9083.818323633523, 9092.40899341544, 8900.37697361185, 8904.821903561893, 8976.506292153928, 8985.0, 9005.459672419676, 41260.587394126276, 41564.79217603923, 41611.37582936259, 41690.37464438036, 41734.791326043174, 3603.045193023851, 3608.1200003955128, 3686.8340924658455, 3691.151035261878, 3705.4256590228556, 33687.4946875797, 33779.32441351184, 34193.829030854686, 34208.65791342079, 34342.48486272708, 4441.844535441244, 4458.08609235106, 4535.478419981711, 4557.270836666151, 4573.336866154422, 251384.0, 260061.0, 260570.0, 261231.0, 262919.68540157366, 34264.972050838514, 35038.299234015176, 35160.82419587886, 56881.0, 57189.71405143031, 36669.816650916575, 36798.0, 36802.63197368046, 36831.4475282871, 36894.077648058475, 14507.854921450651, 14529.128252304896, 14665.706685866224, 14669.413223471154, 14706.926465367605, 13181.0, 13197.0, 13238.602841914759, 13276.20342779417, 13283.867161328457, 8374.995000599967, 8391.8670979417, 8427.452215605967, 8432.74701758936, 8451.492910425393, 3261.0705948804953, 3288.2272665923488, 3297.86808527661, 3309.93380132396, 3367.74741894354, 1001.8246806808779, 1039.564240186177, 1052.3054783842626, 1112.204773586873, 1113.204059097749, 32415.0, 32618.347633047208, 32664.0, 32998.3400331992, 33546.3290734184, 1067.8558394616628, 1114.57089020726, 1123.1744667669257, 1139.4758411130972, 1193.0574845871665, 16830.831691682928, 17225.65548689019, 17259.827401726074, 17397.217125229396, 17555.385561505285, 570970.0, 572128.0, 572494.0, 576342.0, 577046.0, 59129.0, 59264.0, 59466.40533594609, 59878.70060649669, 59897.0, 1313.3039489070807, 1359.4766015084067, 1370.4723681382739, 1377.758892193862, 1380.6617378742274, 31111.37777244397, 31790.523142152422, 32340.0, 32777.50833737448, 33152.1711957203, 58512.4148758507, 59584.70207648934, 59586.40413595809, 59595.70202148962, 59770.701146493986, 544180.0, 546466.0, 548234.0, 549545.0, 552184.0, 28288.43423131567, 28979.56530652, 28980.130596082152, 43517.564824352616, 44474.0, 47678.0, 48157.27764083471, 48974.26538601995, 49661.25508117309, 50173.24740128828, 41415.58584414118, 41764.582354177284, 41888.790556047024, 42138.57861421347, 43290.56709432865, 41542.58457415508, 41620.37569436521, 42010.36984445174, 42595.787021064694, 43608.0, 41457.37813932854, 41977.580224197365, 42347.3647895288, 42452.787736061124, 44873.32690009718, 33429.331413372085, 36854.0, 37280.0, 39214.0, 39540.60459395369, 28761.85619071975, 28948.42103157967, 29142.125736227947, 29308.70691293145, 29325.26686832846], "value": 19202.187588928366, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.12462940323377, 380.15036393660165, 393.19983832900044, 396.32624538284915, 412.6430637498565, 15274.465393711222, 18918.716219256705, 19990.50023749407, 20819.27132550361, 20848.47878803031, 19207.711884321747, 19483.220671173138, 20156.294529691426, 20330.39008829734, 20409.591808163867, 5613.298337707776, 5710.628809127394, 5853.0, 5856.267966504187, 5871.941280587203, 5736.799212027579, 5742.425757424266, 5745.2818397700285, 5757.222774925373, 5801.593888427812, 5638.915416268759, 5746.741396637161, 5768.567357448208, 5769.221155144044, 5808.680522571257, 5687.943120568782, 5741.110127930177, 5747.166660834177, 5769.5672824538115, 5780.739866706008, 5047.924281135749, 5146.0, 5163.561097306733, 5176.715280659562, 5196.792128314863, 23983.640245396335, 24157.516849663083, 24533.38666533351, 24703.62944555833, 25132.246032619052, 2550.553653110698, 2597.545429549821, 2633.789296856266, 2923.108451922163, 3206.6312374076815, 10481.947590262, 10998.615048473264, 12623.495060197582, 13821.723565528633, 15264.236788160548, 1941.631090092878, 1968.7046942958527, 1986.3941497843152, 2098.0768461876723, 2123.3205374280237, 50872.491275087144, 51073.489265107244, 51223.0, 52099.47900520984, 79914.60042699808, 11185.66443006711, 11306.773864522664, 11413.144014198802, 11455.942720286512, 11671.88328116725, 12019.519219231308, 12704.110712250238, 12758.872411275768, 15897.205139742966, 15988.840111598967, 7847.764567062883, 7956.880646790303, 8145.185481451926, 8228.30059444942, 8340.124286949784, 8260.339172866277, 8368.0, 8463.74608761738, 8510.148985101441, 8572.27135693473, 4107.876763697094, 4141.855035073758, 4172.520160181557, 4202.642775364128, 4271.594198551133, 1970.9704354434696, 1982.9504262393268, 2012.9496762581052, 2030.9796902031087, 2037.1443993522755, 945.7588314979636, 957.4159762544842, 975.1077763846001, 978.9265805064649, 1007.2093406675724, 16836.0, 19720.30978915731, 20067.29764458237, 20545.69181462279, 20619.793802062086, 977.7653363192925, 981.4062492192121, 986.6004268271362, 988.229181238635, 1003.0871906565137, 10938.070264027647, 11017.355834599639, 11212.66362009141, 11254.887451125383, 11275.943620281847, 451004.0, 452929.0, 456401.0, 472378.0, 475867.0, 99765.50117249512, 100315.49842250741, 101681.0, 101786.0, 104303.0, 963.4700914496999, 974.91713204377, 992.5136683025265, 995.1193194023341, 999.4053538144792, 16221.35114595403, 17701.0, 17885.95215806536, 17988.460346189637, 18074.277028918696, 31871.0, 34686.47970280498, 41918.790406047774, 45405.77297113493, 46778.53221467742, 60589.394106058375, 61232.69383653053, 61371.69314153401, 61662.383376165664, 62470.06294905671, 8494.490330580185, 8593.8710919335, 8712.956435217784, 8822.823543529223, 8949.552522373986, 13310.267935263653, 14245.35895884667, 14667.706645867236, 15051.548453546411, 15140.864435167186, 12350.567730129402, 12383.257004579755, 12724.300163490727, 13172.802407963696, 13195.142315749446, 12492.937535312265, 12576.30830304342, 12824.615261542169, 12835.294058826854, 13045.804312935124, 12547.372631368213, 13113.27876966776, 13120.737585248433, 13161.802572961606, 13172.670683232996, 9067.773305667148, 9089.454632722058, 9179.862302065341, 9237.07629237071, 9312.906870931203, 9476.384035037701, 12407.565735199225, 12804.359782011048, 12843.0, 13105.2136871788], "value": 9369.798778075212, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1496.1621491964497, 1530.18899983009, 1691.9746203806944, 1799.7390378395125, 1830.4508647405783, 7471.850562988737, 8700.260477859381, 8793.252573531257, 9377.578008989594, 9459.858102128457, 8910.50992195429, 9055.728328150166, 9150.86273705895, 9162.31282653802, 9164.129407706258, 2319.0723710515845, 2376.5246950609862, 2380.0241900820665, 2389.0443822470975, 2392.95214095718, 2276.8633881967053, 2292.541491701658, 2340.8361414700976, 2342.9414264643433, 2343.8710870902178, 2313.6298192289237, 2324.5931961906686, 2331.9300420987397, 2352.4001379648166, 2352.8588284702887, 2229.799318061366, 2233.129079658934, 2249.5725812095648, 2250.122452243618, 2250.819934405252, 2248.067052173346, 2283.2237039406514, 2301.689271948282, 2303.4126297794123, 2309.734380546225, 9183.03578124294, 9221.769455763593, 9242.81514369709, 9251.676191333338, 9299.48852813095, 5221.973890130563, 5300.0459917214885, 5326.094563924142, 5346.893062138774, 5355.2770375999135, 3233.417984762742, 3361.9495707564406, 3387.9661203388146, 3446.5691788526433, 3465.5321531593163, 1084.9367619732707, 1091.328832767842, 1096.4956120184725, 1112.104755671684, 1116.7152376144031, 12813.423395947204, 12929.48282068716, 12998.0, 13027.348632568428, 13076.019298552646, 4615.746133962664, 4649.442066951988, 4765.237561990065, 4801.759912004386, 4825.30033145192, 10917.344959302467, 10921.39932303715, 10929.726756831144, 10933.56265749377, 10938.890611093788, 5447.536959358499, 5460.781568737286, 5460.945390546044, 5486.61593688438, 5488.725563721878, 4274.059706864485, 4855.587275081587, 5008.57427118699, 5022.447530771612, 5025.824096156617, 3979.741316814456, 4042.413849991735, 4137.338025915839, 4160.750354978711, 4179.393987871802, 1284.6724085358173, 1313.074282630743, 1315.2700251360395, 1317.1372750848209, 1326.2838067443665, 996.9202463803024, 1020.8009438159636, 1027.7584767579613, 1049.7585555322166, 1051.500537244818, 6035.969820150871, 6095.1771510845465, 6132.78535251273, 6188.597741146811, 6222.222222222223, 443.31065193624227, 446.0387864152756, 448.6209153265485, 450.6259804362371, 454.82943896038984, 4305.332673435622, 4320.157569274024, 4372.693911426233, 4385.583369579885, 4391.736495810262, 10790.460476976119, 11043.503042362952, 11063.059639930696, 11153.832692509619, 11225.607103751492, 10847.349159050482, 10948.945255273673, 10988.890111098786, 11134.33194008362, 11193.16051296156, 8318.584070796436, 8328.791780205422, 8345.165483451729, 8443.95778021106, 8455.915440845512, 6003.219581454383, 6033.849153771191, 6069.2110025696375, 6221.502279817694, 6224.595401298901, 9947.502624868872, 9986.60053597848, 10307.845382319121, 10318.638847640297, 10362.533685983997, 10346.32748871321, 10348.793024139324, 10590.735231619272, 10604.840927385942, 10627.415492148006, 6898.413634841095, 7736.574488402966, 7779.805504862424, 7990.960045199737, 8000.199980001953, 8798.780030499289, 8893.510856902933, 9000.684976025808, 9003.054679258583, 9005.729828105168, 7441.144268409203, 7573.166951635206, 7754.495957762728, 7772.883406749016, 8078.596070196584, 7497.10034795828, 7559.735409260649, 7669.693212271447, 7712.691492340244, 7754.534727916343, 6737.225219099866, 6806.149231346082, 6832.521723479507, 6861.828454288683, 6899.413549848319, 5307.150855863043, 5397.8110766123, 5519.227308176778, 5523.28197334344, 5553.139263414178, 5279.788808447619, 5379.973100134631, 5403.378611459732, 5439.809606663748, 5470.781168753205], "value": 4645.0794766277, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.3142765905429, 333.2551746845799, 339.123366098635, 341.23903694760685, 345.0975698548297, 5437.102878025131, 5569.526590239824, 5691.288588926384, 5703.543716502681, 5744.3968383319725, 5591.916121258185, 5605.607607467479, 5608.46719561642, 5620.634658747179, 5668.68822214778, 4368.97815510922, 4372.016296333315, 4372.622623873485, 4382.0, 4388.210122178007, 4106.630403263705, 4341.565843415665, 4354.303311470149, 4381.904523869032, 4410.2943529035365, 4289.5924887135825, 4296.8281268749215, 4317.11499142675, 4320.28715261983, 4325.961769175391, 4332.436783218193, 4335.263005289093, 4335.501417336984, 4351.042770590465, 4397.824087036514, 3776.8866933992026, 3822.0062783676444, 3852.171783066626, 3870.6516413522636, 3873.1091848874917, 5418.810341638064, 5469.617126801126, 5479.342478902558, 5501.642393244426, 5551.528120109796, 4973.239851882204, 4985.626078044161, 5003.124453220672, 5013.373328333958, 5024.171011783052, 5778.3643799182055, 5858.531317494633, 5891.823245302648, 5892.175095486636, 5931.169636250928, 4168.437260969791, 4173.332266837322, 4188.4136220929095, 4195.964956995855, 4202.3696445533105, 6108.877822443571, 6138.294096178952, 6144.5698801083945, 6155.353687862755, 6162.22972128484, 4063.593640635972, 4271.743695378287, 4304.91390172201, 4309.870703878889, 4310.353446982915, 4332.610065094157, 4339.869803905888, 4354.804033818423, 4362.6509879210225, 4368.497622773421, 5019.222020586815, 5019.322391477177, 5019.874503137377, 5039.82360617384, 5043.142665746832, 5772.797952071657, 5894.762099958971, 5932.169496270526, 5988.970055149696, 5999.5800293979, 1481.2297605245212, 1498.400639744111, 1498.5279636914338, 1499.9025063371064, 1509.9169545675093, 933.2315262577378, 955.5365647660878, 955.6320816485703, 967.4292167620997, 969.4183489906, 5088.0, 5108.846734597968, 5127.590152548513, 5131.281020858054, 5189.896202075937, 5301.204819277139, 5306.673331667083, 5317.750328672759, 5328.946710532845, 5377.7733359983695, 5120.516549473502, 5154.92267615986, 5158.3552055993005, 5358.544523715528, 5876.7355469004, 3213.7268332191557, 3229.54786329914, 3236.207129253348, 3255.9837200813845, 3257.250832308535, 6124.295705993779, 6337.334579869047, 6352.745890164434, 6358.459530939922, 6378.968105159444, 6177.62934223948, 6180.567360284737, 6185.721642526097, 6195.876082478415, 6196.10156527301, 6306.905396419057, 6326.0, 6368.235811702532, 6386.0, 6390.329015453403, 5845.0, 6071.453569178795, 6077.693295941393, 6078.7264573093435, 6091.664958427329, 5957.463828255478, 5995.790147344822, 5997.820065398045, 6014.428629280212, 6024.427679370453, 5704.971475142598, 6281.434670879643, 6319.873602528016, 6332.905006424815, 6355.680176735551, 4182.309918863353, 4205.1379467208535, 4217.578242175758, 4240.512341080692, 4246.747209573122, 6050.334463208956, 6073.939260607514, 6077.6353418795015, 6108.786192483241, 6125.203723515914, 5698.54411647059, 5868.911966320594, 5892.0, 5899.646021238739, 5922.822315330547, 5834.541364658835, 5855.1602472801505, 5859.882802344015, 5881.264841894763, 5907.91138132937, 5533.557315414838, 5805.187273781589, 5808.767649293981, 5828.271466066742, 5861.325947515919, 5925.762969481172, 5927.303077099996, 5961.225040744849, 5982.670953097621, 5999.5800293979, 5876.3536011039605, 5884.382139875423, 5913.408659134052, 5916.970415147896, 5952.910706339495], "value": 4452.412862087408, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [753.9736109236178, 754.4718696912159, 792.6116203060502, 832.5379414424993, 855.4610595324946, 15156.242187890603, 16353.754693679604, 16442.177891105443, 16470.67058658826, 16475.50573482796, 14882.627934301649, 15046.849531504682, 15063.77404338933, 15097.77353339698, 15132.546023619281, 656.5010591950129, 771.7607541662074, 795.4193438789687, 814.3810703865075, 814.7840822182127, 805.3919290935336, 809.8663720486113, 815.0911733417256, 816.6325153680867, 818.3902992270766, 855.4525103933456, 856.2593356746431, 858.0818524179131, 858.4977787994, 861.8017855893148, 847.0724556610533, 851.0680804519042, 853.3770347646191, 853.9274161696263, 854.5599016506474, 623.7130919776909, 624.1386886097202, 626.5394934722975, 627.3036929008797, 629.2291942370605, 14381.424743010268, 14521.636959076002, 14527.564173074825, 14553.0, 14597.0, 14365.425382984668, 14558.199299038548, 15294.082355058732, 15430.0, 15780.210989450596, 13506.797398039038, 13671.86328136716, 13718.38267277975, 13741.450341986409, 13786.724265514633, 4620.768961551909, 4641.512641172696, 4652.092841895832, 4736.265878788793, 4848.781804818792, 77532.0, 79107.20892791114, 79233.20766792315, 80105.19894801035, 80547.0, 10686.14510839131, 11032.503537340679, 11445.198836081561, 11492.367919764492, 11793.823092653616, 20910.37268881936, 20958.580828383347, 21009.0, 21030.684539731916, 21089.261875834578, 8863.423877448075, 8983.371164018456, 9027.729168124966, 9278.582463789146, 9360.672376466791, 5059.392872855281, 5076.086304465158, 5115.283860259567, 5138.897222055538, 5235.554977826928, 3340.1148695595684, 3430.485427185942, 3440.1571614954496, 3446.827658617059, 3460.740444466675, 601.7232073246356, 605.881853038662, 608.6256951974592, 609.2810483629271, 616.4605969776445, 658.58180055665, 695.9630151074862, 749.3031480722871, 756.7389250708496, 768.4582369429539, 9549.809003819884, 9557.0, 10069.288221002447, 10233.846492302622, 10888.78222435547, 741.4846681556267, 754.5359603843597, 766.2605585609801, 772.8686123359042, 790.4387884601997, 4892.0, 4909.263610458388, 5112.565431938327, 5115.7442127893455, 5147.948520514822, 69990.65004674943, 84421.0, 115370.0, 115411.0, 117259.0, 100463.0, 100851.49574252228, 102773.0, 105067.0, 105430.0, 79898.6005069971, 86415.0, 89413.29400295005, 89614.0, 90168.0, 9488.478133702713, 9512.668226448164, 9823.477361009054, 10045.899541004497, 10219.0, 51023.48976510188, 52968.73515632397, 53215.733921330146, 53568.0, 54544.0, 76048.71447902563, 77163.61418192873, 79576.0, 79670.0, 79899.60050199712, 13397.397117129947, 13449.848024316063, 13668.0, 13709.383077761724, 13722.176669399469, 15500.0, 15643.0, 15699.607509812346, 16472.25874835659, 16477.67044659124, 14000.859991399955, 14066.507672231422, 14383.19008206894, 14469.710605788036, 14483.78274325865, 14776.704465910407, 14796.778048329068, 15068.171250581323, 15107.093574385572, 15130.319135638703, 14068.577942661326, 14168.83470849121, 14222.217778022308, 14386.42454301858, 14443.205623690797, 11998.880011199777, 12043.337616431181, 12054.276743395425, 12120.939395302967, 12171.817422738843, 11749.823752643888, 11843.644690659294, 11853.466594003117, 11976.520939162336, 12037.578684745991], "value": 7819.046655072889, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1526.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 106.0, 110.0, 112.0, 112.0, 112.0, 110.0, 112.0, 111.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 118.0, 144.0, 163.0, 121.0, 145.0, 140.0, 118.0, 191.0, 116.0], "value": 141.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 164.0, 162.0, 163.0, 164.0, 178.0, 161.0, 161.0, 161.0], "value": 163.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 75.0, 178.0, 76.0, 75.0, 74.0, 75.0, 184.0, 76.0], "value": 96.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 145.0, 85.0, 84.0, 85.0, 144.0, 85.0, 85.0, 149.0], "value": 103.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 118.0, 117.0, 119.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 147.0, 149.0, 147.0, 146.0, 148.0, 147.0, 148.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 96.0, 97.0, 96.0, 97.0, 97.0, 95.0, 96.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 56.0, 55.0, 54.0, 56.0, 54.0, 56.0, 55.0, 54.0, 55.0], "value": 54.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 63.0, 64.0, 63.0, 63.0, 65.0, 63.0, 63.0], "value": 63.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 79.0, 78.0, 78.0, 77.0, 77.0, 78.0, 82.0, 77.0], "value": 77.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 138.0, 123.0, 128.0, 135.0, 120.0, 123.0, 126.0, 167.0, 133.0], "value": 132.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 158.0, 157.0, 155.0, 162.0, 158.0, 156.0, 166.0, 156.0, 155.0], "value": 158.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 64.0, 64.0, 64.0, 67.0, 67.0, 64.0, 64.0, 65.0], "value": 65.1, "unit": "score"}]}]} 05:27:37 INFO - Return code: 0 05:27:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:27:37 ERROR - # TBPL SUCCESS # 05:27:37 INFO - Running post-action listener: _resource_record_post_action 05:27:37 INFO - ##### 05:27:37 INFO - ##### Finished run-tests step (success) 05:27:37 INFO - ##### 05:27:37 INFO - Running post-run listener: _resource_record_post_run 05:27:37 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 184320; Write bytes: 561061888; Read time: 84; Write time: 1356640 05:27:37 INFO - TinderboxPrint: CPU usage
13.4% 05:27:37 INFO - TinderboxPrint: I/O read bytes / time
184,320 / 84 05:27:37 INFO - TinderboxPrint: I/O write bytes / time
561,061,888 / 1,356,640 05:27:37 INFO - TinderboxPrint: CPU idle
8,239.6 (86.6%) 05:27:37 INFO - TinderboxPrint: CPU user
1,207.6 (12.7%) 05:27:37 INFO - TinderboxPrint: Swap in / out
0 / 0 05:27:37 INFO - install - Wall time: 19s; CPU: 17.0%; Read bytes: 0; Write bytes: 265326592; Read time: 0; Write time: 965024 05:27:37 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 184320; Write bytes: 295735296; Read time: 84; Write time: 391616 05:27:38 INFO - Running post-run listener: _upload_blobber_files 05:27:38 INFO - Blob upload gear active. 05:27:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:27:38 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:27:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:27:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:27:38 INFO - (blobuploader) - INFO - Open directory for files ... 05:27:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:27:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:27:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:27:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:27:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:27:42 INFO - (blobuploader) - INFO - Done attempting. 05:27:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:27:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:27:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:27:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:27:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:27:43 INFO - (blobuploader) - INFO - Done attempting. 05:27:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:27:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:27:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:27:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:27:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:27:44 INFO - (blobuploader) - INFO - Done attempting. 05:27:44 INFO - (blobuploader) - INFO - Iteration through files over. 05:27:44 INFO - Return code: 0 05:27:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:27:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:27:44 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/83ae3a0056fb1f1af810a936eb4858446fa67cd4c7261caf895cea0e3bb403ade4a05050aba5ab9669f21311a85fea3a8da935c7aa5f22b0d1e4837fad8b0ad6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5e4a037b0538293cc92c0c361dc488ef85bb7125bf0318cbd0194831647e14548d7db7af51e620f67baed62ca6745dd0877673b51dcdff651d0e21e7543af9be", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ee7fc6157a917c1d520491d3fbc4f0f32d5745771101af26f029a09490b3aba10ca2fed990e040fed45907dcb114ee561052344a582e2362e877f74e8456fb2a"} 05:27:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:27:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:27:44 INFO - Contents: 05:27:44 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/83ae3a0056fb1f1af810a936eb4858446fa67cd4c7261caf895cea0e3bb403ade4a05050aba5ab9669f21311a85fea3a8da935c7aa5f22b0d1e4837fad8b0ad6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5e4a037b0538293cc92c0c361dc488ef85bb7125bf0318cbd0194831647e14548d7db7af51e620f67baed62ca6745dd0877673b51dcdff651d0e21e7543af9be", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ee7fc6157a917c1d520491d3fbc4f0f32d5745771101af26f029a09490b3aba10ca2fed990e040fed45907dcb114ee561052344a582e2362e877f74e8456fb2a"} 05:27:44 INFO - Running post-run listener: copy_logs_to_upload_dir 05:27:44 INFO - Copying logs to upload dir... 05:27:44 INFO - mkdir: /builds/slave/test/build/upload/logs 05:27:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.990844 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-07-11 05:27:44.084068) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-11 05:27:44.087951) ========= 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=df17445c3590ff7897617a0e00000225-1468238827.513368-827136256 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/83ae3a0056fb1f1af810a936eb4858446fa67cd4c7261caf895cea0e3bb403ade4a05050aba5ab9669f21311a85fea3a8da935c7aa5f22b0d1e4837fad8b0ad6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5e4a037b0538293cc92c0c361dc488ef85bb7125bf0318cbd0194831647e14548d7db7af51e620f67baed62ca6745dd0877673b51dcdff651d0e21e7543af9be", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ee7fc6157a917c1d520491d3fbc4f0f32d5745771101af26f029a09490b3aba10ca2fed990e040fed45907dcb114ee561052344a582e2362e877f74e8456fb2a"} build_url:https://queue.taskcluster.net/v1/task/coEJbLhqTci38c6RWN6rzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011330 build_url: 'https://queue.taskcluster.net/v1/task/coEJbLhqTci38c6RWN6rzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/83ae3a0056fb1f1af810a936eb4858446fa67cd4c7261caf895cea0e3bb403ade4a05050aba5ab9669f21311a85fea3a8da935c7aa5f22b0d1e4837fad8b0ad6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5e4a037b0538293cc92c0c361dc488ef85bb7125bf0318cbd0194831647e14548d7db7af51e620f67baed62ca6745dd0877673b51dcdff651d0e21e7543af9be", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ee7fc6157a917c1d520491d3fbc4f0f32d5745771101af26f029a09490b3aba10ca2fed990e040fed45907dcb114ee561052344a582e2362e877f74e8456fb2a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-11 05:27:44.114424) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 05:27:44.114923) ========= 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=df17445c3590ff7897617a0e00000225-1468238827.513368-827136256 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004395 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 05:27:44.199368) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-11 05:27:44.200106) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-11 05:27:44.200687) ========= ========= Total master_lag: 0.41 =========