builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-029 starttime: 1483371357.65 results: success (0) revision: 495c17aa9f9919ee8982af861101e6cf0a5a8883 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-02 07:35:57.650031) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-02 07:35:57.650782) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-02 07:35:57.651090) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-02 07:35:57.665906) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-02 07:35:57.666269) ========= 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=ba164b0a7b0ec7655860e956000001c1-1483371188.653610-372016290 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-02 07:35:59-- 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: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.4M=0s 2017-01-02 07:35:59 (46.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.363195 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-02 07:35:58.043230) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-02 07:35:58.043564) ========= 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=ba164b0a7b0ec7655860e956000001c1-1483371188.653610-372016290 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021336 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-02 07:35:58.093538) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-02 07:35:58.093875) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 495c17aa9f9919ee8982af861101e6cf0a5a8883 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 495c17aa9f9919ee8982af861101e6cf0a5a8883 --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=ba164b0a7b0ec7655860e956000001c1-1483371188.653610-372016290 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-02 07:35:59,675 truncating revision to first 12 chars 2017-01-02 07:35:59,675 Setting DEBUG logging. 2017-01-02 07:35:59,675 attempt 1/10 2017-01-02 07:35:59,675 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/495c17aa9f99?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-02 07:35:59,986 unpacking tar archive at: mozilla-central-495c17aa9f99/testing/mozharness/ program finished with exit code 0 elapsedTime=0.628302 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-02 07:35:58.738267) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-02 07:35:58.738920) ========= script_repo_revision: 495c17aa9f9919ee8982af861101e6cf0a5a8883 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-02 07:35:58.739727) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-02 07:35:58.740306) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-02 07:35:58.751488) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-01-02 07:35:58.751904) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ba164b0a7b0ec7655860e956000001c1-1483371188.653610-372016290 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:36:00 INFO - MultiFileLogger online at 20170102 07:36:00 in /builds/slave/test 07:36:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 07:36:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:36:00 INFO - {'append_to_log': False, 07:36:00 INFO - 'base_work_dir': '/builds/slave/test', 07:36:00 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:36:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:36:00 INFO - 'branch': 'Firefox-Non-PGO', 07:36:00 INFO - 'buildbot_json_path': 'buildprops.json', 07:36:00 INFO - 'config_files': ('talos/linux_config.py',), 07:36:00 INFO - 'default_actions': ('clobber', 07:36:00 INFO - 'read-buildbot-config', 07:36:00 INFO - 'download-and-extract', 07:36:00 INFO - 'populate-webroot', 07:36:00 INFO - 'create-virtualenv', 07:36:00 INFO - 'install', 07:36:00 INFO - 'run-tests'), 07:36:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:36:00 INFO - 'download_minidump_stackwalk': True, 07:36:00 INFO - 'download_symbols': 'ondemand', 07:36:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:36:00 INFO - 'tooltool.py': '/tools/tooltool.py', 07:36:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:36:00 INFO - '/tools/misc-python/virtualenv.py')}, 07:36:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:36:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:36:00 INFO - 'installer_path': 'installer.exe', 07:36:00 INFO - 'log_level': 'info', 07:36:00 INFO - 'log_name': 'talos', 07:36:00 INFO - 'log_to_console': True, 07:36:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:36:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:36:00 INFO - 'opt_config_files': (), 07:36:00 INFO - 'pip_index': False, 07:36:00 INFO - 'sps_profile': False, 07:36:00 INFO - 'sps_profile_interval': 0, 07:36:00 INFO - 'suite': 'dromaeojs-e10s', 07:36:00 INFO - 'system_bits': '32', 07:36:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:36:00 INFO - 'title': 'talos-linux64-ix-029', 07:36:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:36:00 INFO - 'use_talos_json': True, 07:36:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:36:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:36:00 INFO - 'work_dir': 'build'} 07:36:00 INFO - [mozharness: 2017-01-02 15:36:00.438329Z] Running clobber step. 07:36:00 INFO - Running pre-action listener: _resource_record_pre_action 07:36:00 INFO - Running main action method: clobber 07:36:00 INFO - rmtree: /builds/slave/test/build 07:36:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:36:00 INFO - Running post-action listener: _resource_record_post_action 07:36:00 INFO - [mozharness: 2017-01-02 15:36:00.893306Z] Finished clobber step (success) 07:36:00 INFO - [mozharness: 2017-01-02 15:36:00.893407Z] Running read-buildbot-config step. 07:36:00 INFO - Running pre-action listener: _resource_record_pre_action 07:36:00 INFO - Running main action method: read_buildbot_config 07:36:00 INFO - Using buildbot properties: 07:36:00 INFO - { 07:36:00 INFO - "project": "", 07:36:00 INFO - "product": "firefox", 07:36:00 INFO - "who": "ffxbld@noreply.mozilla.org", 07:36:00 INFO - "installer_path": "public/build/target.tar.bz2", 07:36:00 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 07:36:00 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 07:36:00 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 07:36:00 INFO - "stage_platform": "linux64", 07:36:00 INFO - "basedir": "/builds/slave/test", 07:36:00 INFO - "buildnumber": 595, 07:36:00 INFO - "platform": "ubuntu64_hw", 07:36:00 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:36:00 INFO - "slavebuilddir": "test", 07:36:00 INFO - "taskId": "IhbDevOhRFGw8iMDjZ8IoQ", 07:36:00 INFO - "branch": "mozilla-central", 07:36:00 INFO - "script_repo_revision": "production", 07:36:00 INFO - "revision": "495c17aa9f9919ee8982af861101e6cf0a5a8883", 07:36:00 INFO - "slavename": "talos-linux64-ix-029", 07:36:00 INFO - "repo_path": "mozilla-central" 07:36:00 INFO - } 07:36:00 INFO - Finding installer, test and symbols from parent task. 07:36:00 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IhbDevOhRFGw8iMDjZ8IoQ'}, attempt #1 07:36:01 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IhbDevOhRFGw8iMDjZ8IoQ'}, attempt #1 07:36:01 INFO - Task dependencies: JsEJES8QQ3yOsvS55PSnqg 07:36:01 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JsEJES8QQ3yOsvS55PSnqg'}, attempt #1 07:36:02 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/JsEJES8QQ3yOsvS55PSnqg/artifacts/public/build/target.tar.bz2 07:36:02 INFO - Set test_url: https://queue.taskcluster.net/v1/task/JsEJES8QQ3yOsvS55PSnqg/artifacts/public/build/test_packages.json 07:36:02 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/JsEJES8QQ3yOsvS55PSnqg/artifacts/public/build/target.crashreporter-symbols.zip 07:36:02 INFO - Running post-action listener: _resource_record_post_action 07:36:02 INFO - [mozharness: 2017-01-02 15:36:02.310723Z] Finished read-buildbot-config step (success) 07:36:02 INFO - [mozharness: 2017-01-02 15:36:02.310941Z] Running download-and-extract step. 07:36:02 INFO - Running pre-action listener: _resource_record_pre_action 07:36:02 INFO - Running main action method: download_and_extract 07:36:02 INFO - mkdir: /builds/slave/test/build/tests 07:36:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:02 INFO - trying https://queue.taskcluster.net/v1/task/JsEJES8QQ3yOsvS55PSnqg/artifacts/public/build/target.test_packages.json 07:36:02 INFO - Downloading https://queue.taskcluster.net/v1/task/JsEJES8QQ3yOsvS55PSnqg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 07:36:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JsEJES8QQ3yOsvS55PSnqg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 07:36:02 INFO - Downloaded 896 bytes. 07:36:02 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 07:36:02 INFO - Using the following test package requirements: 07:36:02 INFO - {u'common': [u'target.common.tests.zip'], 07:36:02 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 07:36:02 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 07:36:02 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 07:36:02 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 07:36:02 INFO - u'mozbase': [u'target.common.tests.zip'], 07:36:02 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 07:36:02 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 07:36:02 INFO - u'web-platform': [u'target.common.tests.zip', 07:36:02 INFO - u'target.web-platform.tests.zip'], 07:36:02 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 07:36:02 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 07:36:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JsEJES8QQ3yOsvS55PSnqg/artifacts/public/build/target.common.tests.zip 07:36:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JsEJES8QQ3yOsvS55PSnqg/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:36:02 INFO - Fetch https://queue.taskcluster.net/v1/task/JsEJES8QQ3yOsvS55PSnqg/artifacts/public/build/target.common.tests.zip into memory 07:36:03 INFO - Expected file size: 20246928 07:36:03 INFO - Obtained file size: 20246928 07:36:07 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 07:36:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JsEJES8QQ3yOsvS55PSnqg/artifacts/public/build/target.common.tests.zip 07:36:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JsEJES8QQ3yOsvS55PSnqg/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:36:07 INFO - Fetch https://queue.taskcluster.net/v1/task/JsEJES8QQ3yOsvS55PSnqg/artifacts/public/build/target.common.tests.zip into memory 07:36:08 INFO - Expected file size: 20246928 07:36:08 INFO - Obtained file size: 20246928 07:36:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JsEJES8QQ3yOsvS55PSnqg/artifacts/public/build/target.talos.tests.zip 07:36:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JsEJES8QQ3yOsvS55PSnqg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 07:36:13 INFO - Fetch https://queue.taskcluster.net/v1/task/JsEJES8QQ3yOsvS55PSnqg/artifacts/public/build/target.talos.tests.zip into memory 07:36:13 INFO - Expected file size: 14409776 07:36:13 INFO - Obtained file size: 14409776 07:36: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:14 INFO - trying https://queue.taskcluster.net/v1/task/JsEJES8QQ3yOsvS55PSnqg/artifacts/public/build/target.tar.bz2 07:36:14 INFO - Downloading https://queue.taskcluster.net/v1/task/JsEJES8QQ3yOsvS55PSnqg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 07:36:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JsEJES8QQ3yOsvS55PSnqg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 07:36:15 INFO - Downloaded 55876956 bytes. 07:36:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JsEJES8QQ3yOsvS55PSnqg/artifacts/public/build/target.tar.bz2 07:36:15 INFO - mkdir: /builds/slave/test/properties 07:36:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:36:15 INFO - Writing to file /builds/slave/test/properties/build_url 07:36:15 INFO - Contents: 07:36:15 INFO - build_url:https://queue.taskcluster.net/v1/task/JsEJES8QQ3yOsvS55PSnqg/artifacts/public/build/target.tar.bz2 07:36:15 INFO - Running post-action listener: _resource_record_post_action 07:36:15 INFO - Running post-action listener: set_extra_try_arguments 07:36:15 INFO - [mozharness: 2017-01-02 15:36:15.075420Z] Finished download-and-extract step (success) 07:36:15 INFO - [mozharness: 2017-01-02 15:36:15.075517Z] Running populate-webroot step. 07:36:15 INFO - Running pre-action listener: _resource_record_pre_action 07:36:15 INFO - Running main action method: populate_webroot 07:36:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:36:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:36:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:36:15 INFO - '--tppagecycles', 07:36:15 INFO - '7'], 07:36:15 INFO - 'tests': ['tsvgm']}}, 07:36:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:36:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:36:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:36:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:36:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:36:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:36:15 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:36:15 INFO - 'talos_options': ['--disable-e10s'], 07:36:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:36:15 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:36:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:36:15 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:36:15 INFO - 'talos_options': ['--disable-e10s'], 07:36:15 INFO - 'tests': ['damp', 'tps']}, 07:36:15 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:36:15 INFO - 'tests': ['damp', 'tps']}, 07:36:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:36:15 INFO - 'tests': ['dromaeo_dom']}, 07:36:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:36:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:36:15 INFO - 'tests': ['basic_compositor_video']}, 07:36:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:36:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:36:15 INFO - 'tests': ['a11yr', 07:36:15 INFO - 'ts_paint', 07:36:15 INFO - 'tpaint', 07:36:15 INFO - 'sessionrestore', 07:36:15 INFO - 'sessionrestore_no_auto_restore', 07:36:15 INFO - 'tabpaint']}, 07:36:15 INFO - 'other-e10s': {'tests': ['a11yr', 07:36:15 INFO - 'ts_paint', 07:36:15 INFO - 'tpaint', 07:36:15 INFO - 'sessionrestore', 07:36:15 INFO - 'sessionrestore_no_auto_restore', 07:36:15 INFO - 'tabpaint']}, 07:36:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:36:15 INFO - 'ts_paint', 07:36:15 INFO - 'tpaint', 07:36:15 INFO - 'sessionrestore', 07:36:15 INFO - 'sessionrestore_no_auto_restore', 07:36:15 INFO - 'tabpaint']}, 07:36:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:36:15 INFO - 'ts_paint', 07:36:15 INFO - 'tpaint', 07:36:15 INFO - 'sessionrestore', 07:36:15 INFO - 'sessionrestore_no_auto_restore', 07:36:15 INFO - 'tabpaint']}, 07:36:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:36:15 INFO - 'tests': ['a11yr', 07:36:15 INFO - 'ts_paint', 07:36:15 INFO - 'tpaint', 07:36:15 INFO - 'sessionrestore', 07:36:15 INFO - 'sessionrestore_no_auto_restore', 07:36:15 INFO - 'tabpaint']}, 07:36:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:36:15 INFO - 'tests': ['a11yr', 07:36:15 INFO - 'ts_paint', 07:36:15 INFO - 'tpaint', 07:36:15 INFO - 'sessionrestore', 07:36:15 INFO - 'sessionrestore_no_auto_restore', 07:36:15 INFO - 'tabpaint']}, 07:36:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:36:15 INFO - 'tests': ['tsvgx', 07:36:15 INFO - 'tsvgr_opacity', 07:36:15 INFO - 'tart', 07:36:15 INFO - 'tscrollx', 07:36:15 INFO - 'cart', 07:36:15 INFO - 'tsvg_static']}, 07:36:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:36:15 INFO - 'tsvgr_opacity', 07:36:15 INFO - 'tart', 07:36:15 INFO - 'tscrollx', 07:36:15 INFO - 'cart', 07:36:15 INFO - 'tsvg_static']}, 07:36:15 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:36:15 INFO - 'talos_options': ['--disable-e10s'], 07:36:15 INFO - 'tests': ['tp5o']}, 07:36:15 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:36:15 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:36:15 INFO - 'talos_options': ['--disable-e10s', 07:36:15 INFO - '--xperf_path', 07:36:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:36:15 INFO - 'tests': ['tp5n']}, 07:36:15 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:36:15 INFO - 'talos_options': ['--xperf_path', 07:36:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:36:15 INFO - 'tests': ['tp5n']}}, 07:36:15 INFO - 'talos.zip': {'path': '', 07:36:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:36:15 INFO - Running post-action listener: _resource_record_post_action 07:36:15 INFO - [mozharness: 2017-01-02 15:36:15.088706Z] Finished populate-webroot step (success) 07:36:15 INFO - [mozharness: 2017-01-02 15:36:15.088797Z] Running create-virtualenv step. 07:36:15 INFO - Running pre-action listener: _resource_record_pre_action 07:36:15 INFO - Running main action method: create_virtualenv 07:36:15 INFO - Creating virtualenv /builds/slave/test/build/venv 07:36:15 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 07:36:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:36:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:36:15 INFO - Using real prefix '/usr' 07:36:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:36:15 INFO - Installing distribute.............................................................................................................................................................................................done. 07:36:17 INFO - Installing pip.................done. 07:36:17 INFO - Return code: 0 07:36:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:36:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:36:17 INFO - Reading from file tmpfile_stdout 07:36:17 INFO - Output received: 07:36:17 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 07:36:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:36: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:17 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 0x16661f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1777a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19d8480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d5820>, '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 0x19d6520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d69b0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1483371188.653610-372016290', '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 07:36:17 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 07:36:17 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 07:36:17 INFO - Using env: {'DISPLAY': ':0', 07:36:17 INFO - 'HOME': '/home/cltbld', 07:36:17 INFO - 'LANG': 'en_US.UTF-8', 07:36:17 INFO - 'LANGUAGE': 'en_US:en', 07:36:17 INFO - 'LOGNAME': 'cltbld', 07:36:17 INFO - 'MAIL': '/var/mail/cltbld', 07:36:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:17 INFO - 'MOZ_NO_REMOTE': '1', 07:36:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:17 INFO - 'NO_EM_RESTART': '1', 07:36:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:17 INFO - 'PWD': '/builds/slave/test', 07:36:17 INFO - 'SHELL': '/bin/bash', 07:36:17 INFO - 'SHLVL': '1', 07:36:17 INFO - 'TERM': 'linux', 07:36:17 INFO - 'TMOUT': '86400', 07:36:17 INFO - 'USER': 'cltbld', 07:36:17 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1483371188.653610-372016290', 07:36:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:17 INFO - '_': '/tools/buildbot/bin/python'} 07:36:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:18 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 07:36:18 INFO - Cleaning up... 07:36:18 INFO - Return code: 0 07:36:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:36:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:18 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 0x16661f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1777a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19d8480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d5820>, '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 0x19d6520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d69b0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1483371188.653610-372016290', '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 07:36:18 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 07:36:18 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 07:36:18 INFO - Using env: {'DISPLAY': ':0', 07:36:18 INFO - 'HOME': '/home/cltbld', 07:36:18 INFO - 'LANG': 'en_US.UTF-8', 07:36:18 INFO - 'LANGUAGE': 'en_US:en', 07:36:18 INFO - 'LOGNAME': 'cltbld', 07:36:18 INFO - 'MAIL': '/var/mail/cltbld', 07:36:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:18 INFO - 'MOZ_NO_REMOTE': '1', 07:36:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:18 INFO - 'NO_EM_RESTART': '1', 07:36:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:18 INFO - 'PWD': '/builds/slave/test', 07:36:18 INFO - 'SHELL': '/bin/bash', 07:36:18 INFO - 'SHLVL': '1', 07:36:18 INFO - 'TERM': 'linux', 07:36:18 INFO - 'TMOUT': '86400', 07:36:18 INFO - 'USER': 'cltbld', 07:36:18 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1483371188.653610-372016290', 07:36:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:18 INFO - '_': '/tools/buildbot/bin/python'} 07:36:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:18 INFO - Downloading/unpacking psutil>=3.1.1 07:36:18 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 07:36:18 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 07:36:18 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 07:36:18 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 07:36:18 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 07:36:18 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 07:36:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:36:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:36:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:36:20 INFO - Installing collected packages: psutil 07:36:20 INFO - Running setup.py install for psutil 07:36:20 INFO - building 'psutil._psutil_linux' extension 07:36:20 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 07:36:20 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 07:36:20 INFO - building 'psutil._psutil_posix' extension 07:36:20 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 07:36:20 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 07:36:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:36:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:36:20 INFO - Successfully installed psutil 07:36:20 INFO - Cleaning up... 07:36:21 INFO - Return code: 0 07:36:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:36:21 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:21 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:21 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 0x16661f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1777a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19d8480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d5820>, '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 0x19d6520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d69b0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1483371188.653610-372016290', '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 07:36:21 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 07:36:21 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 07:36:21 INFO - Using env: {'DISPLAY': ':0', 07:36:21 INFO - 'HOME': '/home/cltbld', 07:36:21 INFO - 'LANG': 'en_US.UTF-8', 07:36:21 INFO - 'LANGUAGE': 'en_US:en', 07:36:21 INFO - 'LOGNAME': 'cltbld', 07:36:21 INFO - 'MAIL': '/var/mail/cltbld', 07:36:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:21 INFO - 'MOZ_NO_REMOTE': '1', 07:36:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:21 INFO - 'NO_EM_RESTART': '1', 07:36:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:21 INFO - 'PWD': '/builds/slave/test', 07:36:21 INFO - 'SHELL': '/bin/bash', 07:36:21 INFO - 'SHLVL': '1', 07:36:21 INFO - 'TERM': 'linux', 07:36:21 INFO - 'TMOUT': '86400', 07:36:21 INFO - 'USER': 'cltbld', 07:36:21 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1483371188.653610-372016290', 07:36:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:21 INFO - '_': '/tools/buildbot/bin/python'} 07:36:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:36:21 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 07:36:21 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 07:36:21 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 07:36:21 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 07:36:21 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 07:36:21 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 07:36:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:36:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:36:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:36:23 INFO - Installing collected packages: mozsystemmonitor 07:36:23 INFO - Running setup.py install for mozsystemmonitor 07:36:23 INFO - Successfully installed mozsystemmonitor 07:36:23 INFO - Cleaning up... 07:36:23 INFO - Return code: 0 07:36:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:36:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:23 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 0x16661f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1777a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19d8480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d5820>, '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 0x19d6520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d69b0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1483371188.653610-372016290', '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 07:36:23 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 07:36:23 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 07:36:23 INFO - Using env: {'DISPLAY': ':0', 07:36:23 INFO - 'HOME': '/home/cltbld', 07:36:23 INFO - 'LANG': 'en_US.UTF-8', 07:36:23 INFO - 'LANGUAGE': 'en_US:en', 07:36:23 INFO - 'LOGNAME': 'cltbld', 07:36:23 INFO - 'MAIL': '/var/mail/cltbld', 07:36:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:23 INFO - 'MOZ_NO_REMOTE': '1', 07:36:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:23 INFO - 'NO_EM_RESTART': '1', 07:36:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:23 INFO - 'PWD': '/builds/slave/test', 07:36:23 INFO - 'SHELL': '/bin/bash', 07:36:23 INFO - 'SHLVL': '1', 07:36:23 INFO - 'TERM': 'linux', 07:36:23 INFO - 'TMOUT': '86400', 07:36:23 INFO - 'USER': 'cltbld', 07:36:23 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1483371188.653610-372016290', 07:36:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:23 INFO - '_': '/tools/buildbot/bin/python'} 07:36:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:23 INFO - Downloading/unpacking jsonschema==2.5.1 07:36:23 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 07:36:23 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 07:36:23 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 07:36:23 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 07:36:23 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 07:36:23 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 07:36:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:36:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:36:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:25 INFO - Downloading functools32-3.2.3-2.tar.gz 07:36:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:36:25 INFO - warning: no files found matching '*.txt' 07:36:25 INFO - no previously-included directories found matching 'build' 07:36:25 INFO - no previously-included directories found matching 'dist' 07:36:25 INFO - no previously-included directories found matching '.git*' 07:36:25 INFO - Installing collected packages: jsonschema, functools32 07:36:25 INFO - Running setup.py install for functools32 07:36:26 INFO - warning: no files found matching '*.txt' 07:36:26 INFO - no previously-included directories found matching 'build' 07:36:26 INFO - no previously-included directories found matching 'dist' 07:36:26 INFO - no previously-included directories found matching '.git*' 07:36:26 INFO - Successfully installed jsonschema functools32 07:36:26 INFO - Cleaning up... 07:36:26 INFO - Return code: 0 07:36:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:36: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36: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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16661f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1777a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19d8480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d5820>, '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 0x19d6520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d69b0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1483371188.653610-372016290', '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 07:36: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:36: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 functools32==3.2.3-2 07:36:26 INFO - Using env: {'DISPLAY': ':0', 07:36:26 INFO - 'HOME': '/home/cltbld', 07:36:26 INFO - 'LANG': 'en_US.UTF-8', 07:36:26 INFO - 'LANGUAGE': 'en_US:en', 07:36:26 INFO - 'LOGNAME': 'cltbld', 07:36:26 INFO - 'MAIL': '/var/mail/cltbld', 07:36:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:26 INFO - 'MOZ_NO_REMOTE': '1', 07:36:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:26 INFO - 'NO_EM_RESTART': '1', 07:36:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:26 INFO - 'PWD': '/builds/slave/test', 07:36:26 INFO - 'SHELL': '/bin/bash', 07:36:26 INFO - 'SHLVL': '1', 07:36:26 INFO - 'TERM': 'linux', 07:36:26 INFO - 'TMOUT': '86400', 07:36:26 INFO - 'USER': 'cltbld', 07:36:26 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1483371188.653610-372016290', 07:36:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:26 INFO - '_': '/tools/buildbot/bin/python'} 07:36:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:36:26 INFO - Cleaning up... 07:36:26 INFO - Return code: 0 07:36:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:36: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36: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', '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 0x16661f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1777a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19d8480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d5820>, '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 0x19d6520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d69b0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1483371188.653610-372016290', '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 07:36: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:36: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 blobuploader==1.2.4 07:36:26 INFO - Using env: {'DISPLAY': ':0', 07:36:26 INFO - 'HOME': '/home/cltbld', 07:36:26 INFO - 'LANG': 'en_US.UTF-8', 07:36:26 INFO - 'LANGUAGE': 'en_US:en', 07:36:26 INFO - 'LOGNAME': 'cltbld', 07:36:26 INFO - 'MAIL': '/var/mail/cltbld', 07:36:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:26 INFO - 'MOZ_NO_REMOTE': '1', 07:36:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:26 INFO - 'NO_EM_RESTART': '1', 07:36:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:26 INFO - 'PWD': '/builds/slave/test', 07:36:26 INFO - 'SHELL': '/bin/bash', 07:36:26 INFO - 'SHLVL': '1', 07:36:26 INFO - 'TERM': 'linux', 07:36:26 INFO - 'TMOUT': '86400', 07:36:26 INFO - 'USER': 'cltbld', 07:36:26 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1483371188.653610-372016290', 07:36:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:26 INFO - '_': '/tools/buildbot/bin/python'} 07:36:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:26 INFO - Downloading/unpacking blobuploader==1.2.4 07:36: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 07:36: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 07:36: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 07:36: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 07:36: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 07:36: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 07:36:28 INFO - Downloading blobuploader-1.2.4.tar.gz 07:36:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:36:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:36:28 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 07:36:28 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 07:36:28 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 07:36:28 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 07:36:28 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 07:36:28 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 07:36:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:36:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:36: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 07:36: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 07:36: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 07:36: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 07:36: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 07:36: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 07:36:29 INFO - Downloading docopt-0.6.1.tar.gz 07:36:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:36:29 INFO - Installing collected packages: blobuploader, requests, docopt 07:36:29 INFO - Running setup.py install for blobuploader 07:36:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:36:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:36:29 INFO - Running setup.py install for requests 07:36:29 INFO - Running setup.py install for docopt 07:36:29 INFO - Successfully installed blobuploader requests docopt 07:36:29 INFO - Cleaning up... 07:36:29 INFO - Return code: 0 07:36:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:36: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:29 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 0x16661f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1777a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19d8480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d5820>, '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 0x19d6520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d69b0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1483371188.653610-372016290', '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 07:36:29 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 07:36:29 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 07:36:29 INFO - Using env: {'DISPLAY': ':0', 07:36:29 INFO - 'HOME': '/home/cltbld', 07:36:29 INFO - 'LANG': 'en_US.UTF-8', 07:36:29 INFO - 'LANGUAGE': 'en_US:en', 07:36:29 INFO - 'LOGNAME': 'cltbld', 07:36:29 INFO - 'MAIL': '/var/mail/cltbld', 07:36:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:29 INFO - 'MOZ_NO_REMOTE': '1', 07:36:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:29 INFO - 'NO_EM_RESTART': '1', 07:36:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:29 INFO - 'PWD': '/builds/slave/test', 07:36:29 INFO - 'SHELL': '/bin/bash', 07:36:29 INFO - 'SHLVL': '1', 07:36:29 INFO - 'TERM': 'linux', 07:36:29 INFO - 'TMOUT': '86400', 07:36:29 INFO - 'USER': 'cltbld', 07:36:29 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1483371188.653610-372016290', 07:36:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:29 INFO - '_': '/tools/buildbot/bin/python'} 07:36:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:36:30 INFO - Running setup.py (path:/tmp/pip-Bpzud7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:36:30 INFO - Running setup.py (path:/tmp/pip-9hXOxf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:36:30 INFO - Running setup.py (path:/tmp/pip-UEp6rS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:36:30 INFO - Running setup.py (path:/tmp/pip-ChpL5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:36:30 INFO - Running setup.py (path:/tmp/pip-X8ZG21-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:36:30 INFO - Running setup.py (path:/tmp/pip-jG_Wy7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:36:30 INFO - Running setup.py (path:/tmp/pip-_SwxcC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:36:30 INFO - Running setup.py (path:/tmp/pip-UP835q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:36:30 INFO - Running setup.py (path:/tmp/pip-rPvv3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:36:30 INFO - Running setup.py (path:/tmp/pip-KRU2fG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:36:30 INFO - Running setup.py (path:/tmp/pip-IhDHQc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:36:31 INFO - Running setup.py (path:/tmp/pip-rvp7ye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:36:31 INFO - Running setup.py (path:/tmp/pip-eiQivA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:36:31 INFO - Running setup.py (path:/tmp/pip-ep9eZw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:31 INFO - Running setup.py (path:/tmp/pip-Kv9l92-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:36:31 INFO - Running setup.py (path:/tmp/pip-6y7G9A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:36:31 INFO - Running setup.py (path:/tmp/pip-Ryor15-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:36:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:36:31 INFO - Running setup.py install for manifestparser 07:36:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:36:31 INFO - Running setup.py install for mozcrash 07:36:31 INFO - Running setup.py install for mozdebug 07:36:31 INFO - Running setup.py install for mozdevice 07:36:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:36:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:36:31 INFO - Running setup.py install for mozfile 07:36:31 INFO - Running setup.py install for mozhttpd 07:36:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:36:32 INFO - Running setup.py install for mozinfo 07:36:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:36:32 INFO - Running setup.py install for mozInstall 07:36:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:36:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:36:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:36:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:36:32 INFO - Running setup.py install for mozleak 07:36:32 INFO - Running setup.py install for mozlog 07:36:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:36:32 INFO - Running setup.py install for moznetwork 07:36:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:36:32 INFO - Running setup.py install for mozprocess 07:36:32 INFO - Running setup.py install for mozprofile 07:36:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:36:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:36:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:36:32 INFO - Running setup.py install for mozrunner 07:36:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:36:32 INFO - Running setup.py install for mozscreenshot 07:36:32 INFO - Running setup.py install for moztest 07:36:33 INFO - Running setup.py install for mozversion 07:36:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:36:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:36:33 INFO - Cleaning up... 07:36:33 INFO - Return code: 0 07:36:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:36:33 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:33 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:33 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 0x16661f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1777a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19d8480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d5820>, '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 0x19d6520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d69b0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1483371188.653610-372016290', '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 07:36:33 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 07:36:33 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 07:36:33 INFO - Using env: {'DISPLAY': ':0', 07:36:33 INFO - 'HOME': '/home/cltbld', 07:36:33 INFO - 'LANG': 'en_US.UTF-8', 07:36:33 INFO - 'LANGUAGE': 'en_US:en', 07:36:33 INFO - 'LOGNAME': 'cltbld', 07:36:33 INFO - 'MAIL': '/var/mail/cltbld', 07:36:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:33 INFO - 'MOZ_NO_REMOTE': '1', 07:36:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:33 INFO - 'NO_EM_RESTART': '1', 07:36:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:33 INFO - 'PWD': '/builds/slave/test', 07:36:33 INFO - 'SHELL': '/bin/bash', 07:36:33 INFO - 'SHLVL': '1', 07:36:33 INFO - 'TERM': 'linux', 07:36:33 INFO - 'TMOUT': '86400', 07:36:33 INFO - 'USER': 'cltbld', 07:36:33 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1483371188.653610-372016290', 07:36:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:33 INFO - '_': '/tools/buildbot/bin/python'} 07:36:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:36:33 INFO - Running setup.py (path:/tmp/pip-1BG4z2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:36:33 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)) 07:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:36:33 INFO - Running setup.py (path:/tmp/pip-NLMfaT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:36:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 07:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:36:33 INFO - Running setup.py (path:/tmp/pip-LWYQKA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:36:33 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)) 07:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:36:33 INFO - Running setup.py (path:/tmp/pip-VdHXQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:36:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 07:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:36:33 INFO - Running setup.py (path:/tmp/pip-8FFTnB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:36:33 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)) 07:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:36:33 INFO - Running setup.py (path:/tmp/pip-ARe2V0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:36:33 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)) 07:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:36:33 INFO - Running setup.py (path:/tmp/pip-JnvzxO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:36:33 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)) 07:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:36:33 INFO - Running setup.py (path:/tmp/pip-zhGHsM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:36:34 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)) 07:36:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:36:34 INFO - Running setup.py (path:/tmp/pip-kr1d1V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:36:34 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)) 07:36:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:36:34 INFO - Running setup.py (path:/tmp/pip-VQE9tf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:36:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 07:36:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:36:34 INFO - Running setup.py (path:/tmp/pip-mskOh9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:36:34 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)) 07:36:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:36:34 INFO - Running setup.py (path:/tmp/pip-egRVHr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:36:34 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)) 07:36:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:36:34 INFO - Running setup.py (path:/tmp/pip-ojCIxz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:36:34 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)) 07:36:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:36:34 INFO - Running setup.py (path:/tmp/pip-dO39Up-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:36:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 07:36:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:34 INFO - Running setup.py (path:/tmp/pip-JtaCZq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:34 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)) 07:36:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:36:34 INFO - Running setup.py (path:/tmp/pip-baSMfD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:36:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 07:36:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:36:34 INFO - Running setup.py (path:/tmp/pip-_Rcvst-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:36:34 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)) 07:36:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:36:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:36:34 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)) 07:36:34 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:36:34 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:36:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:36: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 07:36: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 07:36: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 07:36: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 07:36: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 07:36: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 07:36:36 INFO - Downloading blessings-1.6.tar.gz 07:36:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:36:36 INFO - Installing collected packages: blessings 07:36:36 INFO - Running setup.py install for blessings 07:36:36 INFO - Successfully installed blessings 07:36:36 INFO - Cleaning up... 07:36:36 INFO - Return code: 0 07:36:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:36:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:36:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:36:37 INFO - Reading from file tmpfile_stdout 07:36:37 INFO - Current package versions: 07:36:37 INFO - argparse == 1.2.1 07:36:37 INFO - blessings == 1.6 07:36:37 INFO - blobuploader == 1.2.4 07:36:37 INFO - docopt == 0.6.1 07:36:37 INFO - functools32 == 3.2.3-2 07:36:37 INFO - jsonschema == 2.5.1 07:36:37 INFO - manifestparser == 1.1 07:36:37 INFO - mozInstall == 1.12 07:36:37 INFO - mozcrash == 1.0 07:36:37 INFO - mozdebug == 0.1 07:36:37 INFO - mozdevice == 0.49 07:36:37 INFO - mozfile == 1.2 07:36:37 INFO - mozhttpd == 0.7 07:36:37 INFO - mozinfo == 0.9 07:36:37 INFO - mozleak == 0.1 07:36:37 INFO - mozlog == 3.4 07:36:37 INFO - moznetwork == 0.27 07:36:37 INFO - mozprocess == 0.23 07:36:37 INFO - mozprofile == 0.28 07:36:37 INFO - mozrunner == 6.13 07:36:37 INFO - mozscreenshot == 0.1 07:36:37 INFO - mozsystemmonitor == 0.3 07:36:37 INFO - moztest == 0.8 07:36:37 INFO - mozversion == 1.4 07:36:37 INFO - psutil == 3.1.1 07:36:37 INFO - requests == 1.2.3 07:36:37 INFO - wsgiref == 0.1.2 07:36:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:36: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:37 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 0x16661f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1777a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19d8480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d5820>, '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 0x19d6520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d69b0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1483371188.653610-372016290', '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 07:36:37 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 07:36:37 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 07:36:37 INFO - Using env: {'DISPLAY': ':0', 07:36:37 INFO - 'HOME': '/home/cltbld', 07:36:37 INFO - 'LANG': 'en_US.UTF-8', 07:36:37 INFO - 'LANGUAGE': 'en_US:en', 07:36:37 INFO - 'LOGNAME': 'cltbld', 07:36:37 INFO - 'MAIL': '/var/mail/cltbld', 07:36:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:37 INFO - 'MOZ_NO_REMOTE': '1', 07:36:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:37 INFO - 'NO_EM_RESTART': '1', 07:36:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:37 INFO - 'PWD': '/builds/slave/test', 07:36:37 INFO - 'SHELL': '/bin/bash', 07:36:37 INFO - 'SHLVL': '1', 07:36:37 INFO - 'TERM': 'linux', 07:36:37 INFO - 'TMOUT': '86400', 07:36:37 INFO - 'USER': 'cltbld', 07:36:37 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1483371188.653610-372016290', 07:36:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:37 INFO - '_': '/tools/buildbot/bin/python'} 07:36:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:37 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)) 07:36:37 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)) 07:36:37 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)) 07:36:37 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)) 07:36:37 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)) 07:36:37 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)) 07:36:37 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)) 07:36:37 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)) 07:36:37 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)) 07:36:37 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)) 07:36:37 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)) 07:36:37 INFO - Cleaning up... 07:36:37 INFO - Return code: 0 07:36:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:36: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:37 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 0x16661f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1777a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19d8480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d5820>, '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 0x19d6520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d69b0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1483371188.653610-372016290', '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 07:36:37 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 07:36:37 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 07:36:37 INFO - Using env: {'DISPLAY': ':0', 07:36:37 INFO - 'HOME': '/home/cltbld', 07:36:37 INFO - 'LANG': 'en_US.UTF-8', 07:36:37 INFO - 'LANGUAGE': 'en_US:en', 07:36:37 INFO - 'LOGNAME': 'cltbld', 07:36:37 INFO - 'MAIL': '/var/mail/cltbld', 07:36:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:37 INFO - 'MOZ_NO_REMOTE': '1', 07:36:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:37 INFO - 'NO_EM_RESTART': '1', 07:36:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:37 INFO - 'PWD': '/builds/slave/test', 07:36:37 INFO - 'SHELL': '/bin/bash', 07:36:37 INFO - 'SHLVL': '1', 07:36:37 INFO - 'TERM': 'linux', 07:36:37 INFO - 'TMOUT': '86400', 07:36:37 INFO - 'USER': 'cltbld', 07:36:37 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1483371188.653610-372016290', 07:36:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:37 INFO - '_': '/tools/buildbot/bin/python'} 07:36:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:36:37 INFO - Cleaning up... 07:36:37 INFO - Return code: 0 07:36:37 INFO - Running post-action listener: _resource_record_post_action 07:36:37 INFO - Running post-action listener: _start_resource_monitoring 07:36:37 INFO - Starting resource monitoring. 07:36:37 INFO - [mozharness: 2017-01-02 15:36:37.677533Z] Finished create-virtualenv step (success) 07:36:37 INFO - [mozharness: 2017-01-02 15:36:37.677992Z] Running install step. 07:36:37 INFO - Running pre-action listener: _resource_record_pre_action 07:36:37 INFO - Running main action method: install 07:36:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:36:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:36:37 INFO - Reading from file tmpfile_stdout 07:36:37 INFO - Detecting whether we're running mozinstall >=1.0... 07:36:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:36:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:36:37 INFO - Reading from file tmpfile_stdout 07:36:37 INFO - Output received: 07:36:37 INFO - Usage: mozinstall [options] installer 07:36:37 INFO - Options: 07:36:37 INFO - -h, --help show this help message and exit 07:36:37 INFO - -d DEST, --destination=DEST 07:36:37 INFO - Directory to install application into. [default: 07:36:37 INFO - "/builds/slave/test"] 07:36:37 INFO - --app=APP Application being installed. [default: firefox] 07:36:37 INFO - mkdir: /builds/slave/test/build/application 07:36:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:36:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 07:36:54 INFO - Reading from file tmpfile_stdout 07:36:54 INFO - Output received: 07:36:54 INFO - /builds/slave/test/build/application/firefox/firefox 07:36:54 INFO - Running post-action listener: _resource_record_post_action 07:36:54 INFO - [mozharness: 2017-01-02 15:36:54.782277Z] Finished install step (success) 07:36:54 INFO - [mozharness: 2017-01-02 15:36:54.782548Z] Running run-tests step. 07:36:54 INFO - Running pre-action listener: _resource_record_pre_action 07:36:54 INFO - Running main action method: run_tests 07:36:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:36:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:36:54 INFO - Python 2.7.3 07:36:54 INFO - Return code: 0 07:36:54 INFO - grabbing minidump binary from tooltool 07:36:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:54 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 0x19d5820>, '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 0x19d6520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d69b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:36:54 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 07:36:54 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 07:36:54 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 07:36:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:36:54 INFO - Return code: 0 07:36:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:36:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:36:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:36:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:36:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:36:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JsEJES8QQ3yOsvS55PSnqg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--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 07:36:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JsEJES8QQ3yOsvS55PSnqg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-029 --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 07:36:54 INFO - Using env: {'DISPLAY': ':0', 07:36:54 INFO - 'HOME': '/home/cltbld', 07:36:54 INFO - 'LANG': 'en_US.UTF-8', 07:36:54 INFO - 'LANGUAGE': 'en_US:en', 07:36:54 INFO - 'LOGNAME': 'cltbld', 07:36:54 INFO - 'MAIL': '/var/mail/cltbld', 07:36:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:36:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:36:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:54 INFO - 'MOZ_NO_REMOTE': '1', 07:36:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:36:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:54 INFO - 'NO_EM_RESTART': '1', 07:36:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:54 INFO - 'PWD': '/builds/slave/test', 07:36:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:36:54 INFO - 'SHELL': '/bin/bash', 07:36:54 INFO - 'SHLVL': '1', 07:36:54 INFO - 'TERM': 'linux', 07:36:54 INFO - 'TMOUT': '86400', 07:36:54 INFO - 'USER': 'cltbld', 07:36:54 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1483371188.653610-372016290', 07:36:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:54 INFO - '_': '/tools/buildbot/bin/python'} 07:36:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JsEJES8QQ3yOsvS55PSnqg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--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 07:36:55 INFO - mozversion application_buildid: 20170102150352 07:36:55 INFO - mozversion application_changeset: 495c17aa9f9919ee8982af861101e6cf0a5a8883 07:36:55 INFO - mozversion application_display_name: Nightly 07:36:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:36:55 INFO - mozversion application_name: Firefox 07:36:55 INFO - mozversion application_remotingname: firefox 07:36:55 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:36:55 INFO - mozversion application_vendor: Mozilla 07:36:55 INFO - mozversion application_version: 53.0a1 07:36:55 INFO - mozversion platform_buildid: 20170102150352 07:36:55 INFO - mozversion platform_changeset: 495c17aa9f9919ee8982af861101e6cf0a5a8883 07:36:55 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:36:55 INFO - mozversion platform_version: 53.0a1 07:36:55 INFO - using testdate: 1483371415 07:36:55 INFO - actual date: 1483371415 07:36:55 INFO - starting webserver on 'localhost:45033' 07:36:55 INFO - SUITE-START | Running 2 tests 07:36:55 INFO - TEST-START | dromaeo_css 07:36:55 INFO - operating with platform_type : linux_ 07:36:55 INFO - Initialising browser for dromaeo_css test... 07:36:55 INFO - TEST-INFO | started process 20451 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvkssXi/profile http://localhost:45033/getInfo.html) 07:36:55 INFO - PROCESS | 20451 | 1483371415586 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4986 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2097 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3827 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2831 < callProvider()@resource://gre/modules/AddonManager.jsm:264 < _startProvider()@resource://gre/modules/AddonManager.jsm:771 < startup()@resource://gre/modules/AddonManager.jsm:957 < startup()@resource://gre/modules/AddonManager.jsm:2923 < observe()@resource://gre/components/addonManager.js:65 07:37:00 INFO - PROCESS | 20451 | __metrics Screen width/height:1600/1200 07:37:00 INFO - PROCESS | 20451 | colorDepth:24 07:37:00 INFO - PROCESS | 20451 | Browser inner width/height: 1024/697 07:37:00 INFO - PROCESS | 20451 | __metrics 07:37:00 ERROR - PROCESS | 20451 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3256: TypeError: this.tabs is undefined 07:37:01 INFO - TEST-INFO | 20451: exit 0 07:37:01 INFO - Browser initialized. 07:37:01 INFO - Running cycle 1/1 for dromaeo_css test... 07:37:01 INFO - TEST-INFO | started process 20572 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvkssXi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:37:13 INFO - PROCESS | 20572 | RSS: Main: 157650944 07:37:13 INFO - PROCESS | 20572 | 07:38:03 INFO - PROCESS | 20572 | 1483371483040 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] 07:40:17 INFO - PROCESS | 20572 | Cycle 1(1): loaded http://localhost:45033/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45033/tests/dromaeo/cssquery-ext.html) 07:40:18 INFO - PROCESS | 20572 | RSS: Main: 165294080 07:40:18 INFO - PROCESS | 20572 | 07:42:01 INFO - PROCESS | 20572 | ************************* 07:42:01 INFO - PROCESS | 20572 | A coding exception was thrown and uncaught in a Task. 07:42:01 INFO - PROCESS | 20572 | 07:42:01 INFO - PROCESS | 20572 | Full message: ReferenceError: fetch is not defined 07:42:01 INFO - PROCESS | 20572 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 07:42:01 INFO - PROCESS | 20572 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 07:42:01 INFO - PROCESS | 20572 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 07:42:01 INFO - PROCESS | 20572 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 07:42:01 INFO - PROCESS | 20572 | TaskImpl@resource://gre/modules/Task.jsm:277:3 07:42:01 INFO - PROCESS | 20572 | asyncFunction@resource://gre/modules/Task.jsm:252:14 07:42:01 INFO - PROCESS | 20572 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 07:42:01 INFO - PROCESS | 20572 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 07:42:01 INFO - PROCESS | 20572 | TaskImpl@resource://gre/modules/Task.jsm:277:3 07:42:01 INFO - PROCESS | 20572 | asyncFunction@resource://gre/modules/Task.jsm:252:14 07:42:01 INFO - PROCESS | 20572 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 07:42:01 INFO - PROCESS | 20572 | 07:42:01 INFO - PROCESS | 20572 | ************************* 07:43:21 INFO - PROCESS | 20572 | Cycle 1(1): loaded http://localhost:45033/tests/dromaeo/cssquery-ext.html (next: http://localhost:45033/tests/dromaeo/cssquery-jquery.html) 07:43:21 INFO - PROCESS | 20572 | RSS: Main: 162451456 07:43:21 INFO - PROCESS | 20572 | 07:46:24 INFO - PROCESS | 20572 | Cycle 1(1): loaded http://localhost:45033/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45033/tests/dromaeo/cssquery-mootools.html) 07:46:24 INFO - PROCESS | 20572 | RSS: Main: 169263104 07:46:24 INFO - PROCESS | 20572 | 07:49:26 INFO - PROCESS | 20572 | Cycle 1(1): loaded http://localhost:45033/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45033/tests/dromaeo/cssquery-prototype.html) 07:49:27 INFO - PROCESS | 20572 | RSS: Main: 162541568 07:49:27 INFO - PROCESS | 20572 | 07:52:30 INFO - PROCESS | 20572 | Cycle 1(1): loaded http://localhost:45033/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45033/tests/dromaeo/cssquery-yui.html) 07:52:31 INFO - PROCESS | 20572 | RSS: Main: 165904384 07:52:31 INFO - PROCESS | 20572 | 07:55:33 INFO - PROCESS | 20572 | Cycle 1(1): loaded http://localhost:45033/tests/dromaeo/cssquery-yui.html (next: http://localhost:45033/tests/dromaeo/cssquery-dojo.html) 07:55:34 INFO - PROCESS | 20572 | RSS: Main: 166461440 07:55:34 INFO - PROCESS | 20572 | 07:55:34 INFO - PROCESS | 20572 | __start_tp_report 07:55:34 INFO - PROCESS | 20572 | _x_x_mozilla_page_load 07:55:34 INFO - PROCESS | 20572 | _x_x_mozilla_page_load_details 07:55:34 INFO - PROCESS | 20572 | |i|pagename|runs| 07:55:34 INFO - PROCESS | 20572 | |0;dojo.html;2571.4857028594283;2591.4817036592676;2598.727133650968;2612.229392329263;2640.9603855942164;4739.478657347689;4847.709137451755;4853.10217609742;4869.293952376903;4886.828960986366;4766.475687674353;4774.355462012627;4807.23084306511;4816.63875209359;4852.441969173546;4431.246688063037;4451.6883818132665;4509.842155524558;4543.068670922469;4598.080383923212;4442.133783912139;4488.1696886076015;4511.075229577945;4537.636989040869;4559.635229181674;4329.653627709776;4355.695101342907;4368.890777730582;4464.196444639963;4485.730856148642;4383.079553293812;4400.361947517624;4407.272799987998;4412.051408947092;4412.911741765147;4365;4372.628326592244;4376;4379.233634114017;4379.386885835986;4734.337192793012;4748.050389921995;4749;4749.453812811536;4768.2847572864;5018.121828679967;5089.185730283174;5097.108006098955;5105.948940510584;5107.3105130807235;5143.3570803649545;5153.2270159476;5160.870978225536;5164.431912489623;5166.147585648364;4766.713997160112;4770.570648641639;4804.375431193923;4807.831725889577;4810.6151507879285;5253.36959564847;5272.6309158358545;5285.577153827685;5293.947060529345;5366.463353664602;4978.352814134139;5067.67060141097;5081.2632168335385;5081.59347252219;5084.288199652052;4995.125852975715;5101.387833460009;5137.486251374833;5173.974130129325;5192.247124166975;5005.674631148963;5077.933633936915;5090.414602320707;5134.87162820925;5141.742912854343;5124.20652771527;5128.820491282787;5129.7691603877165;5131.717755523482;5192.5586325162785;4134.627883490501;4168.270552653274;4276.5082015568605;4284.378765079046;4319.3952846601505;3671.2473942841652;3679.5216621839527;3697.6672099511175;3719.088823238324;3757.4551690004796;4501.212287849613;4502.077074199781;4506.571875671806;4513.932291015637;4541.455025396974;5095.668781529189;5230.058589453859;5235.685858848481;5236.502532259429;5244.292020577173;4454.26504626733;4476;4509.301058335963;4518.186726389282;4561;4619.676622636451;4629.213033784265;4645.790939407735;4654.627629789608;4655.348251244828;4878.756062196876;4898.4121905371585;4914.70511769295;4920.138975679313;4959.3552838132255;5094.847154585368;5101.3113229715;5122.257272695364;5133.460986596503;5222.399424066281;4846.055019271208;4853.6602437829015;4864.927026094682;4907.730074845917;4920.507949205051;5091.89830153792;5111.080005599028;5117.513836185556;5120.155174396183;5129.179331306973;5136.101182293159;5143.0999575073465;5146.562542183956;5193.454687257935;5208.453112423141;5016.974915125401;5067.949320506896;5073.974630126826;5125.692458452505;5128;4878.975415162856;5065.366829146356;5071.77177027042;5074.441811400817;5078.314427552233;4842.6368022397755;4854;4897.240927656077;4922.92615610759;4981.900361992667;4996.900061998813;5008.373953255843;5011.123053465702;5017.147084995487;5066.36670416198;4901.264810278487;4913.140200464833;4924.704517728947;4938.234573641092;4940.827071052496 07:55:34 INFO - PROCESS | 20572 | |1;ext.html;514.5420575687638;522.3914140026869;548.7996881138383;552.2411120580953;559.1305519916531;37783;38921.416178757274;38926.61073389269;41715.99999999993;41762.16475670485;38689.61310386896;39229.80385098071;39339.40990885139;39403.40894886579;39507.80246098765;7635.19830417805;7849.25432083954;7915.881261781078;7938.563379014152;9531.571079301448;9551.283653725963;9855.753606159868;9858.605655773761;9869.753256168582;9874.259430542703;9733.90266097337;9749.415035097882;9762.560684769202;9827.262955278347;9836.114749672528;9804.117629413351;9819.705408837746;9821.263405244636;9852.605895764162;9866.309358344883;9667.661631842851;9794.461304628243;9801.607935682565;9802.647364632508;9810.656627018092;33731.6626833731;33755.49366759501;33929.49105763416;34003.82998085018;34206.14484637879;3615.2046549759275;3643.494149513013;3679.816009199529;3686;3727.5340582427198;24714.382140446454;25106.865916397128;25272.620910686353;25281;25472.617910731355;3506.561679790026;3526.435770276769;3530.5586801649793;3558.3594952908466;3560.394732895388;225136;225894;226602.86698566566;226734;227415;42394;42645.57354426478;42658.57341426546;46258.30612540747;46551.06897862092;45613.77193114013;45959;46050.01349824568;46135.53864461379;46175.5382446178;11951.820722689166;12160.452779624939;12165.20926139798;12173.939130304292;12180.208286461351;8379.162083791573;8494.235518803214;9447.716568502956;9538.95230523843;9979.80040399188;15444;15532.514797632324;15575.688486230212;15699.215039247993;15724.213789310488;6485.805425837232;6491.642959637265;6624.56940298879;6679.332066793282;6743.797686069426;805.64551597297;806.3347738116078;807.7940125268019;816.2653611749354;837.656560810065;26367.34081647936;26909.461810763674;27562;27665;28030.85984570064;957.3585697582637;992.4392718114242;993.4536005197112;996.6113215845826;1078.6139810343827;14379.424823007172;14448.927755361156;14479.276036198147;14873.479428220176;14886.627834304012;348039;349445;350457;351816.2409187938;352559;47216.5278347219;47513;47652.761736191096;47871.76064119657;47898.76050619724;1198.497406236963;1214;1233.0628722171034;1236.8824961628632;1243.9626811195499;24904.75095249024;25820;26881.86559067192;26915.461690766468;27205.591916120877;38892.61107389003;40826.1834763309;42411;42483.36274955816;44837;337099;338361;340921;341439;341567;21318.467038324165;21826.236081737698;22361.44096397603;22737;22992.54014919659;35746;36102;36181;36683.63316366802;37087.6291237095;30823.743966380436;31037.689623104383;31796;32243.35513289674;32539.674603253665;30982.84508577443;31083.844580776953;31279.37441251208;31481.370372591962;31883;36556.45165322469;36652.45021324736;36731.81634091812;36739;39325.21349572935;32527.67472325341;33837.830810845786;36421.81789091037;36885;37390;29739.256518587208;29740;29817.403651927274;30352.696473034986;30419 07:55:34 INFO - PROCESS | 20572 | |2;jquery.html;363.06691802068696;377.2116276981109;379.3759266007417;382.79137869860926;393.3490073927649;15729.213539323031;17016.744748828776;17232.74150887736;17274.30902763888;17417.30330786767;15467.30397132129;16170.19149042549;16944.661106777858;16992.49022529323;17072.573185670364;4842.055799119182;5124;5135.897282054357;5140.871478213037;5140.922886156711;5000.349954505909;5071.087204303224;5301.204819277101;5333.706646134461;5374.408815030363;5333.306670132877;5340.06548853951;5343.171808369709;5351.464853514656;5354.27717258169;5161.14841051228;5325.068113080215;5409.215663728776;5414.35027796663;5471.261379713767;5262.578993680497;5310.150375939869;5325.707086110262;5328.067588172094;5338.946610533883;12018.819717704242;12532.937335313265;12664.62006139808;12666.430010649543;12724.363781810873;1994.6509360861792;2037.113855472874;2079.8336133109315;2134.9786502134934;2199.4611320226645;8552.700655477029;8626.266767324785;8671.176238257356;9033.548322583845;9103.908960910372;1614.9354025838952;1635.3785561486677;1664.675388299282;1667.8582320502771;1702.8126906040325;62010.37989620091;62306.68846655783;62830.68584657093;63153.684231579005;64377.678111609144;9408.200302974325;9632.373895696897;9638.084381983701;9660.420374777535;9705.126538611417;12712.300823454614;12765.42555585001;12785.936070319589;12809.359532023362;12848.935755321163;6663.400293973468;6898.241193468714;6932.202796678345;7096.751613693599;7150.034745309421;6693.966530167416;6713.496487763339;6851.897221541681;6868.450523958071;6870.175578930561;3957.3866050762176;3982.6415622593527;4053.5135783706146;4148.23257697327;4175.707700460999;1677.653082101216;1791.480470663493;1820.3173809821317;1823.340759908477;1824.252056656791;792.8731402975496;824.7154731617583;831.8502669519545;832.508819796311;856.3577317012241;15861.603459913595;15894.602634933988;16126.75809862853;16158;16425.91787041081;799.9240072193132;811.4603788480712;822.8066404394963;826.3348004856028;847.1740053447962;9024.413413128257;9056.184943355129;9135.177833994972;9315;9426.434413935185;247000;325013;325779;325999;326044;62306;70204;71381.64309178421;71625.64187179031;71843;985.7732721474101;1009.5860697114148;1013.5185786751234;1017.3844823881593;1026.3174988632475;14747;14980.325885334969;14981.925090374914;15144.54566363011;15272.618184545476;33381;33510;34204.828975855955;34371;34633.826830865684;44444.55555444534;45470.54529454663;45810.54189458063;45992.310115347624;46004;6856.691448884912;7151.713931442892;7184.8922266165;7342.339189472973;7371.152317483344;10713.517891694737;10998.890011099787;11270.267432616854;11389.658310250374;11555.422228888354;9256.95371523138;9304.30217733659;9497.47763872966;9819.45992970365;9896.406215627085;9455.669051583161;9731.513424328898;9774.218062555121;9827.459489728133;9942.453165075991;5541.722913854372;5688.63023903445;9214.769630759285;9488.430694158373;9944.801103977736;7665.770026899202;7678.232176782277;7723.459357845121;7796.259355361231;7801.804954875946;8579.184977427134;10011.59837622748;10181.898181018096;10254.230932680228;10280.126189273995 07:55:34 INFO - PROCESS | 20572 | |3;mootools.html;1323.4639970811818;1329.4283458113011;1330.2484096485484;1332.9600111996645;1334.6996925691717;6665.833354166149;6802.319768023195;7036.73338799016;7441.51630144041;7453.590052547108;7019.087518622585;7268.491205615609;7303;7446.925530744691;7512.211217822119;2100.2019232691555;2145.313499680095;2148.495103650641;2150.311900191939;2154.149111101114;2084.8637492566513;2149.0973791007737;2177.7822217778175;2188.8686678799245;2207.834412419067;2204.0522575292616;2224.8331375146927;2228.108756497406;2231.7545070042283;2233.7319521657423;2090.581883623274;2096.9475763105893;2097;2102.180149741602;2113.9048742806535;2112.0706888968803;2114.3551216878845;2140.9464763380884;2142.678598210281;2159.287435146398;7399.70401183952;7466.6266686665995;7538.020057392559;7556.2443755624545;7556.848863022708;4417.138657961698;4525.683202175849;4540.8864778380475;4559.954400455986;4577.0159415725775;2856.657201135877;2936.163193489845;3016.75865930725;3029.681883402233;3130.5930229070077;1101.3942331717524;1143.7369405036804;1148.3970915269467;1176.1061593189152;1188.518649946773;9569.425834449956;9618.9519052405;9662.75843103921;9676.75808104796;9677.580604848788;3781.773093614392;3980.7412518186225;4005.4792876925812;4038.7172897897453;4079.6124368184974;7798.922010779933;7821.217878212247;7837.7648670539975;7843.764687059397;7849.568273744999;4442.20040392726;4443.133588950188;4457.197704413172;4463.218936686067;4463.709858859163;4028.315186418316;4100.91798164041;4108.609682080198;4115.032967252693;4116.361963895601;3196.9840150799564;3240.659730728287;3326.085326535174;3332;3336.6996970272307;925.1858364639209;933.9486328251876;1004.1715584642699;1022.7392015036266;1106.994465027686;688.90355350251;697.7488104282454;701.9543729657556;716.3266529462289;721.8592374486925;4620.861374158781;4778.211595086772;4792.7124372537755;4829.855104346875;4906.11689895815;837.7495318165601;859.6174702257435;860.1484530315068;871.8525380320891;892.3797960417447;3329.3674201901563;3364.192593777476;3384.6953774160443;3403.7617366784584;3461.1001139703353;8708.91291087081;8796.604152813139;8890.64437422496;8892.021877593459;8896.644134234559;8841.248493878093;8844.292456603456;8845.690400836069;8846.424982376253;8899.15458031486;6538;6792.490563207779;6902.344277293549;6925.376716095576;7054.08296921397;4781.521847815191;4885.633577481632;5004.17431123875;5050.545450909436;5096.796128154981;7837.529748214897;7933.294341716559;8165.979252593425;8198.672053117809;8226.341892648694;8263.834723305621;8288.70989515364;8293;8336.374771892253;8444.451110677786;7023.543469674659;7112.324329188718;7115.181754098345;7116.50184487081;7139.500234983501;7043.7534686285735;7078.362947334765;7128.037714908421;7131.2155662876;7141.535800172972;6409.391107844747;6479.157709497735;6510.7721229756735;6528.347165283433;6535.542512024303;6343.175387199634;6398.616083035033;6443.7744678936015;6458.321876202931;6461.127747754181;5647.463490968352;5671.291088613923;5676.545876329967;5682.687452190169;5706.4864162225595;4114.280000999754;4145;4202.579742025773;4224.978875105605;4300.849470268526;4322.9135417290845;4379.956200438082;4388.51726310112;4455.844045458393;4556.635469162526 07:55:34 INFO - PROCESS | 20572 | |4;prototype.html;338.87631014679636;350.0967503840092;353.466265938433;355.31424351002585;360.80696827197437;4899.877503062421;4921.458639549646;4946.5795407390415;4957.727324997124;4958.256261560768;4915.926261106087;4925.591595522014;4937.210046392578;4946.978816501254;4950.480199579047;3711.536057992751;3848.2111167210655;3867.1298957734566;3893.357595996657;3983.800809959505;3828.483154774098;3838.9040273993096;3846.903827404309;3874.321993651114;3879.243547508237;3809.1810260793923;3815.751976121543;3826.445165451008;3840;3844.2695887781374;3667.2482141161263;3820.331441997639;3842.5196850393563;3844.807759612036;3849.8075096245075;3303.0586282909258;3310.7682462227654;3314;3321.9003429897143;3328.267781088157;4790.353302304179;4808.158572249842;4809.95190048102;4814.181589129857;4844.757762111915;4351.108022855307;4372.256716358195;4375.7155784873885;4385.51759306476;4418.955810441887;5004.524570165829;5141.794328226866;5157.58739300855;5194.792208311663;5222.582193424555;3652.433872749728;3653.2328211075705;3654.1230104774663;3662.926741465182;3682.668559829628;5369.301990741218;5378.327709036371;5396.163594642837;5420.13277875542;5459.645123066988;3644.325799727059;3719.739618226752;3734.2718169956597;3737.7944213068;3751.362268414376;3736.1967177057063;3746.250749850041;3789.3368660484307;3792.1278106035215;3798.4112462568346;4296.550965949379;4309;4309.547497512779;4313.84901528445;4353.107612939403;5058.671186372874;5136.712503997444;5172.844814655567;5183.688978661293;5189.091908916;1275.79587266037;1279.411470723459;1283.153118941494;1285.8264134341932;1286.3761075878192;859.4971941414218;868.7133246028795;881.7487016200353;884.7434244069276;885.4510203673764;4439.66702497314;4456.309272062836;4572.725636461823;4584.266517357207;4647.790849411717;5274.630775845654;5356.232443293781;5360.437154098763;5367.651102678314;5388.003219404422;4572.702774319659;4599.195140850338;4604.286335617984;4606.147862645421;4625.283081122431;2696.8651567421552;2748.2717079973822;2755.4489102179646;2795.203367040384;2801.6918139004692;4841.3222148899185;4897.877553061202;4921.45655128307;4923.433805112386;4962.950370496249;5155.407128180233;5333.200019996954;5335.546478549367;5385.219143224289;5402.648827826179;4854.499932534818;4856.878578035577;4873.780679869415;4904.969956309215;4927.876803079952;5254.7898084076205;5256.579473642176;5262.473752624707;5282.6038047147385;5294.97352513235;4965.205567109245;5183.641443143285;5202.505761952609;5212.478752124757;5217.330454254602;4964.900701986012;5003.34956455673;5004.424491183415;5022.84931452057;5027.949720502748;3712.3317802795755;3718.665320121202;3747.2880152770886;3750.2810462415623;3763.6424539668687;5192.480751924777;5425.457454254543;5428.45715428454;5430.67415955044;5441.238226648194;5153.278541004187;5170.560502357342;5183.611229157753;5197.324347834758;5201.843944681666;5185.611079169153;5193.143131383279;5201.1678131498775;5202.947970520247;5214.243934629533;4980.676256043345;5125.129927240757;5142.408623008252;5143.434222235476;5190.714510701948;4921.753912304442;5069.898602028013;5143;5160.200168973815;5165.251038599457;5006.524380183877;5069.340985671839;5081.745912704424;5081.900040975076;5111.667741596784 07:55:34 INFO - PROCESS | 20572 | |5;yui.html;676.1784431915222;682.0791930893298;736.3851184261142;750.504666919833;761.2729842999934;14260.857391426083;14678.706425871489;14734.778978315333;15376.923115384407;15464.536063918073;14743.48397806077;14798.630034249149;14950.775738363933;14953.177575233358;14959.626009349771;675.4461341699808;787.5117427195119;787.9566623835686;795.252462685077;795.6340083561569;684.9726010959556;807.3541167066353;818.8894499242585;826.9503829770202;829.3531045784267;856.3448961544424;860.1312674199041;861.2033868671485;861.4745005546612;865.809521905183;848.9363297752693;851.9744407667749;853.185208126241;853.7140058080488;855.0850589868843;621.7140115546854;625.8435391152212;627.4572494791972;627.4948666323608;628.7170773152054;12983.415746291439;13208.207507549578;13270.86729132706;13275.60173194796;13760.862391376058;12612.68468288291;13167.67080822987;13174.407151678197;13339.33303334839;13615.387307571184;10287.736697926444;10376.584936602527;10496.527656255486;10705.732356691145;10819.83770243447;3218.5815843940372;3241.38413701396;3264.9020529384156;3297.670232976707;3312.0560640217423;59739.10391344134;59798;60723.392766072655;60739.39260607426;62387;9926.2059035277;10022.649207277711;10130.746731331776;10232.33489823174;10376.42929638862;18478.260869565336;18567.907160464383;18626.627467450846;18655;18659.90670046641;5916.408359164049;5959.702014899238;6171.9691401542705;6182.319944806068;6246.094316324107;3575.3385623659706;3623.1847834237087;3641.5812181599454;3649.9635003649623;3652.872149474809;2867.5411934090444;2931.3404483991358;2936.427396657631;2946.2634341414646;2970.301979034925;455.5057762327845;456.4157877916272;464.0487001646611;467.09616891315414;471.1848502091401;623.2645478335517;640.1230314469113;640.6284355074046;645.3578689204272;649.2079662811362;7470.663820128108;7564.773056808304;8052.6713092339105;8232.670693172206;8517.23344898962;611.4222060153113;624.2820756130486;625.9311475737666;626.2141013028711;635.6821589205397;3888.1282616028643;4022.2960981828646;4035.6973227007506;4078.9184216316103;4138.772367519755;53496.73251633717;63264.367356326766;64794;64899.35100649027;65301.67349163224;52742.47257527452;55124.72437637866;55259.44740552623;55278.72360638171;55443.445565544636;40054.39918401226;42823.571764282584;45993.31010034785;48741.26888096681;48974.02051958941;8438.818565400727;8755.693550725695;8976.506292153994;9283.72148835536;9285.907140928504;31162;31723.20691982719;32602.83698581587;32801.343973119925;33858;37335.81332093322;39782.403263951644;39981.2003759929;40051.198976020896;41185.79407102945;10454.215933805148;10760;10819;10887.727806804893;10894.128469722245;11439.256448330832;11591.76816463683;11603.045812008488;11701.239419437708;11839.585614503796;11899.762004759683;11957.342346170695;12123.151379403356;12197.69505762363;12337.259764414164;11398.715032123931;11410.486528106088;11603.419829008684;11683.591074312359;11731.530738770694;11817.290962542274;12030.15788894769;12370;12799.488020479077;12909.419076141408;9361.625534978797;9509.334346595948;9552.42685438876;9597.712068637951;9864.260180486348;9043.909560904307;9170.908290917272;10097.343672661253;10355.119814815826;10444.42555659446 07:55:34 INFO - PROCESS | 20572 | __end_tp_report 07:55:34 INFO - PROCESS | 20572 | __start_cc_report 07:55:34 INFO - PROCESS | 20572 | _x_x_mozilla_cycle_collect,327 07:55:34 INFO - PROCESS | 20572 | __end_cc_report 07:55:34 INFO - PROCESS | 20572 | __startTimestamp1483372534224__endTimestamp 07:55:34 INFO - PROCESS | 20572 | 07:55:34 INFO - PROCESS | 20572 | ------- Summary: start ------- 07:55:34 INFO - PROCESS | 20572 | Number of tests: 6 07:55:34 INFO - PROCESS | 20572 | 07:55:34 INFO - PROCESS | 20572 | [#0] dojo.html Cycles:165 Average:4754.57 Median:4897.24 stddev:516.75 (10.6%) stddev-sans-first:489.13 07:55:34 INFO - PROCESS | 20572 | Values: 2571.5 2591.5 2598.7 2612.2 2641.0 4739.5 4847.7 4853.1 4869.3 4886.8 4766.5 4774.4 4807.2 4816.6 4852.4 4431.2 4451.7 4509.8 4543.1 4598.1 4442.1 4488.2 4511.1 4537.6 4559.6 4329.7 4355.7 4368.9 4464.2 4485.7 4383.1 4400.4 4407.3 4412.1 4412.9 4365.0 4372.6 4376.0 4379.2 4379.4 4734.3 4748.1 4749.0 4749.5 4768.3 5018.1 5089.2 5097.1 5105.9 5107.3 5143.4 5153.2 5160.9 5164.4 5166.1 4766.7 4770.6 4804.4 4807.8 4810.6 5253.4 5272.6 5285.6 5293.9 5366.5 4978.4 5067.7 5081.3 5081.6 5084.3 4995.1 5101.4 5137.5 5174.0 5192.2 5005.7 5077.9 5090.4 5134.9 5141.7 5124.2 5128.8 5129.8 5131.7 5192.6 4134.6 4168.3 4276.5 4284.4 4319.4 3671.2 3679.5 3697.7 3719.1 3757.5 4501.2 4502.1 4506.6 4513.9 4541.5 5095.7 5230.1 5235.7 5236.5 5244.3 4454.3 4476.0 4509.3 4518.2 4561.0 4619.7 4629.2 4645.8 4654.6 4655.3 4878.8 4898.4 4914.7 4920.1 4959.4 5094.8 5101.3 5122.3 5133.5 5222.4 4846.1 4853.7 4864.9 4907.7 4920.5 5091.9 5111.1 5117.5 5120.2 5129.2 5136.1 5143.1 5146.6 5193.5 5208.5 5017.0 5067.9 5074.0 5125.7 5128.0 4879.0 5065.4 5071.8 5074.4 5078.3 4842.6 4854.0 4897.2 4922.9 4981.9 4996.9 5008.4 5011.1 5017.1 5066.4 4901.3 4913.1 4924.7 4938.2 4940.8 07:55:34 INFO - PROCESS | 20572 | 07:55:34 INFO - PROCESS | 20572 | [#1] ext.html Cycles:180 Average:45239.93 Median:36668.04 stddev:81691.30 (222.8%) stddev-sans-first:81851.44 07:55:34 INFO - PROCESS | 20572 | Values: 514.5 522.4 548.8 552.2 559.1 37783.0 38921.4 38926.6 41716.0 41762.2 38689.6 39229.8 39339.4 39403.4 39507.8 7635.2 7849.3 7915.9 7938.6 9531.6 9551.3 9855.8 9858.6 9869.8 9874.3 9733.9 9749.4 9762.6 9827.3 9836.1 9804.1 9819.7 9821.3 9852.6 9866.3 9667.7 9794.5 9801.6 9802.6 9810.7 33731.7 33755.5 33929.5 34003.8 34206.1 3615.2 3643.5 3679.8 3686.0 3727.5 24714.4 25106.9 25272.6 25281.0 25472.6 3506.6 3526.4 3530.6 3558.4 3560.4 225136.0 225894.0 226602.9 226734.0 227415.0 42394.0 42645.6 42658.6 46258.3 46551.1 45613.8 45959.0 46050.0 46135.5 46175.5 11951.8 12160.5 12165.2 12173.9 12180.2 8379.2 8494.2 9447.7 9539.0 9979.8 15444.0 15532.5 15575.7 15699.2 15724.2 6485.8 6491.6 6624.6 6679.3 6743.8 805.6 806.3 807.8 816.3 837.7 26367.3 26909.5 27562.0 27665.0 28030.9 957.4 992.4 993.5 996.6 1078.6 14379.4 14448.9 14479.3 14873.5 14886.6 348039.0 349445.0 350457.0 351816.2 352559.0 47216.5 47513.0 47652.8 47871.8 47898.8 1198.5 1214.0 1233.1 1236.9 1244.0 24904.8 25820.0 26881.9 26915.5 27205.6 38892.6 40826.2 42411.0 42483.4 44837.0 337099.0 338361.0 340921.0 341439.0 341567.0 21318.5 21826.2 22361.4 22737.0 22992.5 35746.0 36102.0 36181.0 36683.6 37087.6 30823.7 31037.7 31796.0 32243.4 32539.7 30982.8 31083.8 31279.4 31481.4 31883.0 36556.5 36652.5 36731.8 36739.0 39325.2 32527.7 33837.8 36421.8 36885.0 37390.0 29739.3 29740.0 29817.4 30352.7 30419.0 07:55:34 INFO - PROCESS | 20572 | 07:55:34 INFO - PROCESS | 20572 | [#2] jquery.html Cycles:180 Average:20982.05 Median:5211.86 stddev:51709.87 (992.2%) stddev-sans-first:51831.76 07:55:34 INFO - PROCESS | 20572 | Values: 363.1 377.2 379.4 382.8 393.3 15729.2 17016.7 17232.7 17274.3 17417.3 15467.3 16170.2 16944.7 16992.5 17072.6 4842.1 5124.0 5135.9 5140.9 5140.9 5000.3 5071.1 5301.2 5333.7 5374.4 5333.3 5340.1 5343.2 5351.5 5354.3 5161.1 5325.1 5409.2 5414.4 5471.3 5262.6 5310.2 5325.7 5328.1 5338.9 12018.8 12532.9 12664.6 12666.4 12724.4 1994.7 2037.1 2079.8 2135.0 2199.5 8552.7 8626.3 8671.2 9033.5 9103.9 1614.9 1635.4 1664.7 1667.9 1702.8 62010.4 62306.7 62830.7 63153.7 64377.7 9408.2 9632.4 9638.1 9660.4 9705.1 12712.3 12765.4 12785.9 12809.4 12848.9 6663.4 6898.2 6932.2 7096.8 7150.0 6694.0 6713.5 6851.9 6868.5 6870.2 3957.4 3982.6 4053.5 4148.2 4175.7 1677.7 1791.5 1820.3 1823.3 1824.3 792.9 824.7 831.9 832.5 856.4 15861.6 15894.6 16126.8 16158.0 16425.9 799.9 811.5 822.8 826.3 847.2 9024.4 9056.2 9135.2 9315.0 9426.4 247000.0 325013.0 325779.0 325999.0 326044.0 62306.0 70204.0 71381.6 71625.6 71843.0 985.8 1009.6 1013.5 1017.4 1026.3 14747.0 14980.3 14981.9 15144.5 15272.6 33381.0 33510.0 34204.8 34371.0 34633.8 44444.6 45470.5 45810.5 45992.3 46004.0 6856.7 7151.7 7184.9 7342.3 7371.2 10713.5 10998.9 11270.3 11389.7 11555.4 9257.0 9304.3 9497.5 9819.5 9896.4 9455.7 9731.5 9774.2 9827.5 9942.5 5541.7 5688.6 9214.8 9488.4 9944.8 7665.8 7678.2 7723.5 7796.3 7801.8 8579.2 10011.6 10181.9 10254.2 10280.1 07:55:34 INFO - PROCESS | 20572 | 07:55:34 INFO - PROCESS | 20572 | [#3] mootools.html Cycles:180 Average:4833.04 Median:5027.36 stddev:2616.89 (52.1%) stddev-sans-first:2610.94 07:55:34 INFO - PROCESS | 20572 | Values: 1323.5 1329.4 1330.2 1333.0 1334.7 6665.8 6802.3 7036.7 7441.5 7453.6 7019.1 7268.5 7303.0 7446.9 7512.2 2100.2 2145.3 2148.5 2150.3 2154.1 2084.9 2149.1 2177.8 2188.9 2207.8 2204.1 2224.8 2228.1 2231.8 2233.7 2090.6 2096.9 2097.0 2102.2 2113.9 2112.1 2114.4 2140.9 2142.7 2159.3 7399.7 7466.6 7538.0 7556.2 7556.8 4417.1 4525.7 4540.9 4560.0 4577.0 2856.7 2936.2 3016.8 3029.7 3130.6 1101.4 1143.7 1148.4 1176.1 1188.5 9569.4 9619.0 9662.8 9676.8 9677.6 3781.8 3980.7 4005.5 4038.7 4079.6 7798.9 7821.2 7837.8 7843.8 7849.6 4442.2 4443.1 4457.2 4463.2 4463.7 4028.3 4100.9 4108.6 4115.0 4116.4 3197.0 3240.7 3326.1 3332.0 3336.7 925.2 933.9 1004.2 1022.7 1107.0 688.9 697.7 702.0 716.3 721.9 4620.9 4778.2 4792.7 4829.9 4906.1 837.7 859.6 860.1 871.9 892.4 3329.4 3364.2 3384.7 3403.8 3461.1 8708.9 8796.6 8890.6 8892.0 8896.6 8841.2 8844.3 8845.7 8846.4 8899.2 6538.0 6792.5 6902.3 6925.4 7054.1 4781.5 4885.6 5004.2 5050.5 5096.8 7837.5 7933.3 8166.0 8198.7 8226.3 8263.8 8288.7 8293.0 8336.4 8444.5 7023.5 7112.3 7115.2 7116.5 7139.5 7043.8 7078.4 7128.0 7131.2 7141.5 6409.4 6479.2 6510.8 6528.3 6535.5 6343.2 6398.6 6443.8 6458.3 6461.1 5647.5 5671.3 5676.5 5682.7 5706.5 4114.3 4145.0 4202.6 4225.0 4300.8 4322.9 4380.0 4388.5 4455.8 4556.6 07:55:34 INFO - PROCESS | 20572 | 07:55:34 INFO - PROCESS | 20572 | [#4] prototype.html Cycles:180 Average:4277.26 Median:4902.42 stddev:1246.05 (25.4%) stddev-sans-first:1213.97 07:55:34 INFO - PROCESS | 20572 | Values: 338.9 350.1 353.5 355.3 360.8 4899.9 4921.5 4946.6 4957.7 4958.3 4915.9 4925.6 4937.2 4947.0 4950.5 3711.5 3848.2 3867.1 3893.4 3983.8 3828.5 3838.9 3846.9 3874.3 3879.2 3809.2 3815.8 3826.4 3840.0 3844.3 3667.2 3820.3 3842.5 3844.8 3849.8 3303.1 3310.8 3314.0 3321.9 3328.3 4790.4 4808.2 4810.0 4814.2 4844.8 4351.1 4372.3 4375.7 4385.5 4419.0 5004.5 5141.8 5157.6 5194.8 5222.6 3652.4 3653.2 3654.1 3662.9 3682.7 5369.3 5378.3 5396.2 5420.1 5459.6 3644.3 3719.7 3734.3 3737.8 3751.4 3736.2 3746.3 3789.3 3792.1 3798.4 4296.6 4309.0 4309.5 4313.8 4353.1 5058.7 5136.7 5172.8 5183.7 5189.1 1275.8 1279.4 1283.2 1285.8 1286.4 859.5 868.7 881.7 884.7 885.5 4439.7 4456.3 4572.7 4584.3 4647.8 5274.6 5356.2 5360.4 5367.7 5388.0 4572.7 4599.2 4604.3 4606.1 4625.3 2696.9 2748.3 2755.4 2795.2 2801.7 4841.3 4897.9 4921.5 4923.4 4963.0 5155.4 5333.2 5335.5 5385.2 5402.6 4854.5 4856.9 4873.8 4905.0 4927.9 5254.8 5256.6 5262.5 5282.6 5295.0 4965.2 5183.6 5202.5 5212.5 5217.3 4964.9 5003.3 5004.4 5022.8 5027.9 3712.3 3718.7 3747.3 3750.3 3763.6 5192.5 5425.5 5428.5 5430.7 5441.2 5153.3 5170.6 5183.6 5197.3 5201.8 5185.6 5193.1 5201.2 5202.9 5214.2 4980.7 5125.1 5142.4 5143.4 5190.7 4921.8 5069.9 5143.0 5160.2 5165.3 5006.5 5069.3 5081.7 5081.9 5111.7 07:55:34 INFO - PROCESS | 20572 | 07:55:34 INFO - PROCESS | 20572 | [#5] yui.html Cycles:180 Average:14217.28 Median:22632.36 stddev:17101.39 (75.6%) stddev-sans-first:17119.13 07:55:34 INFO - PROCESS | 20572 | Values: 676.2 682.1 736.4 750.5 761.3 14260.9 14678.7 14734.8 15376.9 15464.5 14743.5 14798.6 14950.8 14953.2 14959.6 675.4 787.5 788.0 795.3 795.6 685.0 807.4 818.9 827.0 829.4 856.3 860.1 861.2 861.5 865.8 848.9 852.0 853.2 853.7 855.1 621.7 625.8 627.5 627.5 628.7 12983.4 13208.2 13270.9 13275.6 13760.9 12612.7 13167.7 13174.4 13339.3 13615.4 10287.7 10376.6 10496.5 10705.7 10819.8 3218.6 3241.4 3264.9 3297.7 3312.1 59739.1 59798.0 60723.4 60739.4 62387.0 9926.2 10022.6 10130.7 10232.3 10376.4 18478.3 18567.9 18626.6 18655.0 18659.9 5916.4 5959.7 6172.0 6182.3 6246.1 3575.3 3623.2 3641.6 3650.0 3652.9 2867.5 2931.3 2936.4 2946.3 2970.3 455.5 456.4 464.0 467.1 471.2 623.3 640.1 640.6 645.4 649.2 7470.7 7564.8 8052.7 8232.7 8517.2 611.4 624.3 625.9 626.2 635.7 3888.1 4022.3 4035.7 4078.9 4138.8 53496.7 63264.4 64794.0 64899.4 65301.7 52742.5 55124.7 55259.4 55278.7 55443.4 40054.4 42823.6 45993.3 48741.3 48974.0 8438.8 8755.7 8976.5 9283.7 9285.9 31162.0 31723.2 32602.8 32801.3 33858.0 37335.8 39782.4 39981.2 40051.2 41185.8 10454.2 10760.0 10819.0 10887.7 10894.1 11439.3 11591.8 11603.0 11701.2 11839.6 11899.8 11957.3 12123.2 12197.7 12337.3 11398.7 11410.5 11603.4 11683.6 11731.5 11817.3 12030.2 12370.0 12799.5 12909.4 9361.6 9509.3 9552.4 9597.7 9864.3 9043.9 9170.9 10097.3 10355.1 10444.4 07:55:34 INFO - PROCESS | 20572 | -------- Summary: end -------- 07:55:34 INFO - PROCESS | 20572 | 07:55:35 INFO - TEST-INFO | 20572: exit 0 07:55:35 INFO - TEST-OK | dromaeo_css | took 1119954ms 07:55:35 INFO - TEST-START | kraken 07:55:35 INFO - operating with platform_type : linux_ 07:55:35 INFO - Initialising browser for kraken test... 07:55:35 INFO - TEST-INFO | started process 20920 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCZkGqY/profile http://localhost:45033/getInfo.html) 07:55:35 INFO - PROCESS | 20920 | 1483372535495 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4986 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2097 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3827 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2831 < callProvider()@resource://gre/modules/AddonManager.jsm:264 < _startProvider()@resource://gre/modules/AddonManager.jsm:771 < startup()@resource://gre/modules/AddonManager.jsm:957 < startup()@resource://gre/modules/AddonManager.jsm:2923 < observe()@resource://gre/components/addonManager.js:65 07:55:39 INFO - PROCESS | 20920 | __metrics Screen width/height:1600/1200 07:55:39 INFO - PROCESS | 20920 | colorDepth:24 07:55:39 INFO - PROCESS | 20920 | Browser inner width/height: 1024/697 07:55:39 INFO - PROCESS | 20920 | __metrics 07:55:40 ERROR - PROCESS | 20920 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3256: TypeError: this.tabs is undefined 07:55:41 INFO - TEST-INFO | 20920: exit 0 07:55:41 INFO - Browser initialized. 07:55:41 INFO - Running cycle 1/1 for kraken test... 07:55:41 INFO - TEST-INFO | started process 21039 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCZkGqY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:55:53 INFO - PROCESS | 21039 | RSS: Main: 157990912 07:55:53 INFO - PROCESS | 21039 | 07:55:56 INFO - PROCESS | 21039 | Cycle 1(1): loaded http://localhost:45033/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45033/tests/kraken/driver.html?testName=audio-beat-detection) 07:55:57 INFO - PROCESS | 21039 | RSS: Main: 164114432 07:55:57 INFO - PROCESS | 21039 | 07:55:59 INFO - PROCESS | 21039 | Cycle 1(1): loaded http://localhost:45033/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45033/tests/kraken/driver.html?testName=audio-dft) 07:56:00 INFO - PROCESS | 21039 | RSS: Main: 162861056 07:56:00 INFO - PROCESS | 21039 | 07:56:03 INFO - PROCESS | 21039 | Cycle 1(1): loaded http://localhost:45033/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45033/tests/kraken/driver.html?testName=audio-fft) 07:56:04 INFO - PROCESS | 21039 | RSS: Main: 159846400 07:56:04 INFO - PROCESS | 21039 | 07:56:06 INFO - PROCESS | 21039 | Cycle 1(1): loaded http://localhost:45033/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45033/tests/kraken/driver.html?testName=audio-oscillator) 07:56:06 INFO - PROCESS | 21039 | RSS: Main: 159948800 07:56:06 INFO - PROCESS | 21039 | 07:56:09 INFO - PROCESS | 21039 | Cycle 1(1): loaded http://localhost:45033/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45033/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:56:09 INFO - PROCESS | 21039 | RSS: Main: 160059392 07:56:09 INFO - PROCESS | 21039 | 07:56:12 INFO - PROCESS | 21039 | Cycle 1(1): loaded http://localhost:45033/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45033/tests/kraken/driver.html?testName=imaging-darkroom) 07:56:13 INFO - PROCESS | 21039 | RSS: Main: 163913728 07:56:13 INFO - PROCESS | 21039 | 07:56:17 INFO - PROCESS | 21039 | Cycle 1(1): loaded http://localhost:45033/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45033/tests/kraken/driver.html?testName=imaging-desaturate) 07:56:17 INFO - PROCESS | 21039 | RSS: Main: 161533952 07:56:17 INFO - PROCESS | 21039 | 07:56:20 INFO - PROCESS | 21039 | Cycle 1(1): loaded http://localhost:45033/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45033/tests/kraken/driver.html?testName=json-parse-financial) 07:56:21 INFO - PROCESS | 21039 | RSS: Main: 163434496 07:56:21 INFO - PROCESS | 21039 | 07:56:22 INFO - PROCESS | 21039 | Cycle 1(1): loaded http://localhost:45033/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45033/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:56:23 INFO - PROCESS | 21039 | RSS: Main: 162279424 07:56:23 INFO - PROCESS | 21039 | 07:56:25 INFO - PROCESS | 21039 | Cycle 1(1): loaded http://localhost:45033/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45033/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:56:26 INFO - PROCESS | 21039 | RSS: Main: 162746368 07:56:26 INFO - PROCESS | 21039 | 07:56:28 INFO - PROCESS | 21039 | Cycle 1(1): loaded http://localhost:45033/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45033/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:56:29 INFO - PROCESS | 21039 | RSS: Main: 163098624 07:56:29 INFO - PROCESS | 21039 | 07:56:31 INFO - PROCESS | 21039 | Cycle 1(1): loaded http://localhost:45033/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45033/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:56:32 INFO - PROCESS | 21039 | RSS: Main: 164188160 07:56:32 INFO - PROCESS | 21039 | 07:56:35 INFO - PROCESS | 21039 | Cycle 1(1): loaded http://localhost:45033/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45033/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:56:36 INFO - PROCESS | 21039 | RSS: Main: 162910208 07:56:36 INFO - PROCESS | 21039 | 07:56:38 INFO - PROCESS | 21039 | Cycle 1(1): loaded http://localhost:45033/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45033/tests/kraken/driver.html?testName=ai-astar) 07:56:38 INFO - PROCESS | 21039 | RSS: Main: 164757504 07:56:38 INFO - PROCESS | 21039 | 07:56:38 INFO - PROCESS | 21039 | __start_tp_report 07:56:38 INFO - PROCESS | 21039 | _x_x_mozilla_page_load 07:56:38 INFO - PROCESS | 21039 | _x_x_mozilla_page_load_details 07:56:38 INFO - PROCESS | 21039 | |i|pagename|runs| 07:56:38 INFO - PROCESS | 21039 | |0;ai-astar;107;116;116;116;115;115;116;115;116;115 07:56:38 INFO - PROCESS | 21039 | |1;audio-beat-detection;156;130;133;168;136;127;137;128;152;131 07:56:38 INFO - PROCESS | 21039 | |2;audio-dft;163;165;166;166;163;166;166;163;162;163 07:56:38 INFO - PROCESS | 21039 | |3;audio-fft;78;78;75;112;79;77;78;79;105;77 07:56:38 INFO - PROCESS | 21039 | |4;audio-oscillator;84;85;107;85;85;86;99;85;87;106 07:56:38 INFO - PROCESS | 21039 | |5;imaging-gaussian-blur;118;118;118;119;119;119;118;118;117;118 07:56:38 INFO - PROCESS | 21039 | |6;imaging-darkroom;151;150;150;153;151;151;150;151;151;151 07:56:38 INFO - PROCESS | 21039 | |7;imaging-desaturate;101;96;96;96;96;97;96;95;95;96 07:56:38 INFO - PROCESS | 21039 | |8;json-parse-financial;66;63;64;64;65;65;65;64;66;68 07:56:38 INFO - PROCESS | 21039 | |9;json-stringify-tinderbox;67;70;68;68;68;68;71;69;68;73 07:56:38 INFO - PROCESS | 21039 | |10;stanford-crypto-aes;89;87;86;96;87;96;87;87;85;86 07:56:38 INFO - PROCESS | 21039 | |11;stanford-crypto-ccm;140;146;137;147;137;137;151;134;208;135 07:56:38 INFO - PROCESS | 21039 | |12;stanford-crypto-pbkdf2;183;179;176;176;178;182;186;181;192;181 07:56:38 INFO - PROCESS | 21039 | |13;stanford-crypto-sha256-iterative;71;71;71;71;70;75;72;70;69;70 07:56:38 INFO - PROCESS | 21039 | __end_tp_report 07:56:38 INFO - PROCESS | 21039 | __start_cc_report 07:56:38 INFO - PROCESS | 21039 | _x_x_mozilla_cycle_collect,816 07:56:38 INFO - PROCESS | 21039 | __end_cc_report 07:56:38 INFO - PROCESS | 21039 | __startTimestamp1483372598404__endTimestamp 07:56:38 INFO - PROCESS | 21039 | 07:56:38 INFO - PROCESS | 21039 | ------- Summary: start ------- 07:56:38 INFO - PROCESS | 21039 | Number of tests: 14 07:56:38 INFO - PROCESS | 21039 | 07:56:38 INFO - PROCESS | 21039 | [#0] ai-astar Cycles:10 Average:114.70 Median:116.00 stddev:2.75 (2.4%) stddev-sans-first:0.53 07:56:38 INFO - PROCESS | 21039 | Values: 107.0 116.0 116.0 116.0 115.0 115.0 116.0 115.0 116.0 115.0 07:56:38 INFO - PROCESS | 21039 | 07:56:38 INFO - PROCESS | 21039 | [#1] audio-beat-detection Cycles:10 Average:139.80 Median:136.50 stddev:13.95 (10.2%) stddev-sans-first:13.51 07:56:38 INFO - PROCESS | 21039 | Values: 156.0 130.0 133.0 168.0 136.0 127.0 137.0 128.0 152.0 131.0 07:56:38 INFO - PROCESS | 21039 | 07:56:38 INFO - PROCESS | 21039 | [#2] audio-dft Cycles:10 Average:164.30 Median:165.50 stddev:1.64 (1.0%) stddev-sans-first:1.67 07:56:38 INFO - PROCESS | 21039 | Values: 163.0 165.0 166.0 166.0 163.0 166.0 166.0 163.0 162.0 163.0 07:56:38 INFO - PROCESS | 21039 | 07:56:38 INFO - PROCESS | 21039 | [#3] audio-fft Cycles:10 Average:83.80 Median:78.00 stddev:13.17 (16.9%) stddev-sans-first:13.80 07:56:38 INFO - PROCESS | 21039 | Values: 78.0 78.0 75.0 112.0 79.0 77.0 78.0 79.0 105.0 77.0 07:56:38 INFO - PROCESS | 21039 | 07:56:38 INFO - PROCESS | 21039 | [#4] audio-oscillator Cycles:10 Average:90.90 Median:85.00 stddev:9.30 (10.9%) stddev-sans-first:9.53 07:56:38 INFO - PROCESS | 21039 | Values: 84.0 85.0 107.0 85.0 85.0 86.0 99.0 85.0 87.0 106.0 07:56:38 INFO - PROCESS | 21039 | 07:56:38 INFO - PROCESS | 21039 | [#5] imaging-gaussian-blur Cycles:10 Average:118.20 Median:118.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 07:56:38 INFO - PROCESS | 21039 | Values: 118.0 118.0 118.0 119.0 119.0 119.0 118.0 118.0 117.0 118.0 07:56:38 INFO - PROCESS | 21039 | 07:56:38 INFO - PROCESS | 21039 | [#6] imaging-darkroom Cycles:10 Average:150.90 Median:151.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 07:56:38 INFO - PROCESS | 21039 | Values: 151.0 150.0 150.0 153.0 151.0 151.0 150.0 151.0 151.0 151.0 07:56:38 INFO - PROCESS | 21039 | 07:56:38 INFO - PROCESS | 21039 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.00 stddev:1.71 (1.8%) stddev-sans-first:0.60 07:56:38 INFO - PROCESS | 21039 | Values: 101.0 96.0 96.0 96.0 96.0 97.0 96.0 95.0 95.0 96.0 07:56:38 INFO - PROCESS | 21039 | 07:56:38 INFO - PROCESS | 21039 | [#8] json-parse-financial Cycles:10 Average:65.00 Median:65.00 stddev:1.41 (2.2%) stddev-sans-first:1.45 07:56:38 INFO - PROCESS | 21039 | Values: 66.0 63.0 64.0 64.0 65.0 65.0 65.0 64.0 66.0 68.0 07:56:38 INFO - PROCESS | 21039 | 07:56:38 INFO - PROCESS | 21039 | [#9] json-stringify-tinderbox Cycles:10 Average:69.00 Median:68.50 stddev:1.83 (2.7%) stddev-sans-first:1.79 07:56:38 INFO - PROCESS | 21039 | Values: 67.0 70.0 68.0 68.0 68.0 68.0 71.0 69.0 68.0 73.0 07:56:38 INFO - PROCESS | 21039 | 07:56:38 INFO - PROCESS | 21039 | [#10] stanford-crypto-aes Cycles:10 Average:88.60 Median:87.00 stddev:4.03 (4.6%) stddev-sans-first:4.28 07:56:38 INFO - PROCESS | 21039 | Values: 89.0 87.0 86.0 96.0 87.0 96.0 87.0 87.0 85.0 86.0 07:56:38 INFO - PROCESS | 21039 | 07:56:38 INFO - PROCESS | 21039 | [#11] stanford-crypto-ccm Cycles:10 Average:147.20 Median:143.00 stddev:22.11 (15.5%) stddev-sans-first:23.30 07:56:38 INFO - PROCESS | 21039 | Values: 140.0 146.0 137.0 147.0 137.0 137.0 151.0 134.0 208.0 135.0 07:56:38 INFO - PROCESS | 21039 | 07:56:38 INFO - PROCESS | 21039 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.40 Median:181.50 stddev:4.86 (2.7%) stddev-sans-first:5.12 07:56:38 INFO - PROCESS | 21039 | Values: 183.0 179.0 176.0 176.0 178.0 182.0 186.0 181.0 192.0 181.0 07:56:38 INFO - PROCESS | 21039 | 07:56:38 INFO - PROCESS | 21039 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.00 Median:71.00 stddev:1.63 (2.3%) stddev-sans-first:1.73 07:56:38 INFO - PROCESS | 21039 | Values: 71.0 71.0 71.0 71.0 70.0 75.0 72.0 70.0 69.0 70.0 07:56:38 INFO - PROCESS | 21039 | -------- Summary: end -------- 07:56:38 INFO - PROCESS | 21039 | 07:56:39 INFO - TEST-INFO | 21039: exit 0 07:56:39 INFO - TEST-OK | kraken | took 64524ms 07:56:39 INFO - SUITE-END | took 1184s 07:56:39 INFO - Completed test suite (00:19:44) 07:56:39 INFO - javascript benchmark 07:56:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6259.135934166473, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2571.4857028594283, 2591.4817036592676, 2598.727133650968, 2612.229392329263, 2640.9603855942164, 4739.478657347689, 4847.709137451755, 4853.10217609742, 4869.293952376903, 4886.828960986366, 4766.475687674353, 4774.355462012627, 4807.23084306511, 4816.63875209359, 4852.441969173546, 4431.246688063037, 4451.6883818132665, 4509.842155524558, 4543.068670922469, 4598.080383923212, 4442.133783912139, 4488.1696886076015, 4511.075229577945, 4537.636989040869, 4559.635229181674, 4329.653627709776, 4355.695101342907, 4368.890777730582, 4464.196444639963, 4485.730856148642, 4383.079553293812, 4400.361947517624, 4407.272799987998, 4412.051408947092, 4412.911741765147, 4365.0, 4372.628326592244, 4376.0, 4379.233634114017, 4379.386885835986, 4734.337192793012, 4748.050389921995, 4749.0, 4749.453812811536, 4768.2847572864, 5018.121828679967, 5089.185730283174, 5097.108006098955, 5105.948940510584, 5107.3105130807235, 5143.3570803649545, 5153.2270159476, 5160.870978225536, 5164.431912489623, 5166.147585648364, 4766.713997160112, 4770.570648641639, 4804.375431193923, 4807.831725889577, 4810.6151507879285, 5253.36959564847, 5272.6309158358545, 5285.577153827685, 5293.947060529345, 5366.463353664602, 4978.352814134139, 5067.67060141097, 5081.2632168335385, 5081.59347252219, 5084.288199652052, 4995.125852975715, 5101.387833460009, 5137.486251374833, 5173.974130129325, 5192.247124166975, 5005.674631148963, 5077.933633936915, 5090.414602320707, 5134.87162820925, 5141.742912854343, 5124.20652771527, 5128.820491282787, 5129.7691603877165, 5131.717755523482, 5192.5586325162785, 4134.627883490501, 4168.270552653274, 4276.5082015568605, 4284.378765079046, 4319.3952846601505, 3671.2473942841652, 3679.5216621839527, 3697.6672099511175, 3719.088823238324, 3757.4551690004796, 4501.212287849613, 4502.077074199781, 4506.571875671806, 4513.932291015637, 4541.455025396974, 5095.668781529189, 5230.058589453859, 5235.685858848481, 5236.502532259429, 5244.292020577173, 4454.26504626733, 4476.0, 4509.301058335963, 4518.186726389282, 4561.0, 4619.676622636451, 4629.213033784265, 4645.790939407735, 4654.627629789608, 4655.348251244828, 4878.756062196876, 4898.4121905371585, 4914.70511769295, 4920.138975679313, 4959.3552838132255, 5094.847154585368, 5101.3113229715, 5122.257272695364, 5133.460986596503, 5222.399424066281, 4846.055019271208, 4853.6602437829015, 4864.927026094682, 4907.730074845917, 4920.507949205051, 5091.89830153792, 5111.080005599028, 5117.513836185556, 5120.155174396183, 5129.179331306973, 5136.101182293159, 5143.0999575073465, 5146.562542183956, 5193.454687257935, 5208.453112423141, 5016.974915125401, 5067.949320506896, 5073.974630126826, 5125.692458452505, 5128.0, 4878.975415162856, 5065.366829146356, 5071.77177027042, 5074.441811400817, 5078.314427552233, 4842.6368022397755, 4854.0, 4897.240927656077, 4922.92615610759, 4981.900361992667, 4996.900061998813, 5008.373953255843, 5011.123053465702, 5017.147084995487, 5066.36670416198, 4901.264810278487, 4913.140200464833, 4924.704517728947, 4938.234573641092, 4940.827071052496], "value": 4719.66738883905, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [514.5420575687638, 522.3914140026869, 548.7996881138383, 552.2411120580953, 559.1305519916531, 37783.0, 38921.416178757274, 38926.61073389269, 41715.99999999993, 41762.16475670485, 38689.61310386896, 39229.80385098071, 39339.40990885139, 39403.40894886579, 39507.80246098765, 7635.19830417805, 7849.25432083954, 7915.881261781078, 7938.563379014152, 9531.571079301448, 9551.283653725963, 9855.753606159868, 9858.605655773761, 9869.753256168582, 9874.259430542703, 9733.90266097337, 9749.415035097882, 9762.560684769202, 9827.262955278347, 9836.114749672528, 9804.117629413351, 9819.705408837746, 9821.263405244636, 9852.605895764162, 9866.309358344883, 9667.661631842851, 9794.461304628243, 9801.607935682565, 9802.647364632508, 9810.656627018092, 33731.6626833731, 33755.49366759501, 33929.49105763416, 34003.82998085018, 34206.14484637879, 3615.2046549759275, 3643.494149513013, 3679.816009199529, 3686.0, 3727.5340582427198, 24714.382140446454, 25106.865916397128, 25272.620910686353, 25281.0, 25472.617910731355, 3506.561679790026, 3526.435770276769, 3530.5586801649793, 3558.3594952908466, 3560.394732895388, 225136.0, 225894.0, 226602.86698566566, 226734.0, 227415.0, 42394.0, 42645.57354426478, 42658.57341426546, 46258.30612540747, 46551.06897862092, 45613.77193114013, 45959.0, 46050.01349824568, 46135.53864461379, 46175.5382446178, 11951.820722689166, 12160.452779624939, 12165.20926139798, 12173.939130304292, 12180.208286461351, 8379.162083791573, 8494.235518803214, 9447.716568502956, 9538.95230523843, 9979.80040399188, 15444.0, 15532.514797632324, 15575.688486230212, 15699.215039247993, 15724.213789310488, 6485.805425837232, 6491.642959637265, 6624.56940298879, 6679.332066793282, 6743.797686069426, 805.64551597297, 806.3347738116078, 807.7940125268019, 816.2653611749354, 837.656560810065, 26367.34081647936, 26909.461810763674, 27562.0, 27665.0, 28030.85984570064, 957.3585697582637, 992.4392718114242, 993.4536005197112, 996.6113215845826, 1078.6139810343827, 14379.424823007172, 14448.927755361156, 14479.276036198147, 14873.479428220176, 14886.627834304012, 348039.0, 349445.0, 350457.0, 351816.2409187938, 352559.0, 47216.5278347219, 47513.0, 47652.761736191096, 47871.76064119657, 47898.76050619724, 1198.497406236963, 1214.0, 1233.0628722171034, 1236.8824961628632, 1243.9626811195499, 24904.75095249024, 25820.0, 26881.86559067192, 26915.461690766468, 27205.591916120877, 38892.61107389003, 40826.1834763309, 42411.0, 42483.36274955816, 44837.0, 337099.0, 338361.0, 340921.0, 341439.0, 341567.0, 21318.467038324165, 21826.236081737698, 22361.44096397603, 22737.0, 22992.54014919659, 35746.0, 36102.0, 36181.0, 36683.63316366802, 37087.6291237095, 30823.743966380436, 31037.689623104383, 31796.0, 32243.35513289674, 32539.674603253665, 30982.84508577443, 31083.844580776953, 31279.37441251208, 31481.370372591962, 31883.0, 36556.45165322469, 36652.45021324736, 36731.81634091812, 36739.0, 39325.21349572935, 32527.67472325341, 33837.830810845786, 36421.81789091037, 36885.0, 37390.0, 29739.256518587208, 29740.0, 29817.403651927274, 30352.696473034986, 30419.0], "value": 17190.89600208566, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.06691802068696, 377.2116276981109, 379.3759266007417, 382.79137869860926, 393.3490073927649, 15729.213539323031, 17016.744748828776, 17232.74150887736, 17274.30902763888, 17417.30330786767, 15467.30397132129, 16170.19149042549, 16944.661106777858, 16992.49022529323, 17072.573185670364, 4842.055799119182, 5124.0, 5135.897282054357, 5140.871478213037, 5140.922886156711, 5000.349954505909, 5071.087204303224, 5301.204819277101, 5333.706646134461, 5374.408815030363, 5333.306670132877, 5340.06548853951, 5343.171808369709, 5351.464853514656, 5354.27717258169, 5161.14841051228, 5325.068113080215, 5409.215663728776, 5414.35027796663, 5471.261379713767, 5262.578993680497, 5310.150375939869, 5325.707086110262, 5328.067588172094, 5338.946610533883, 12018.819717704242, 12532.937335313265, 12664.62006139808, 12666.430010649543, 12724.363781810873, 1994.6509360861792, 2037.113855472874, 2079.8336133109315, 2134.9786502134934, 2199.4611320226645, 8552.700655477029, 8626.266767324785, 8671.176238257356, 9033.548322583845, 9103.908960910372, 1614.9354025838952, 1635.3785561486677, 1664.675388299282, 1667.8582320502771, 1702.8126906040325, 62010.37989620091, 62306.68846655783, 62830.68584657093, 63153.684231579005, 64377.678111609144, 9408.200302974325, 9632.373895696897, 9638.084381983701, 9660.420374777535, 9705.126538611417, 12712.300823454614, 12765.42555585001, 12785.936070319589, 12809.359532023362, 12848.935755321163, 6663.400293973468, 6898.241193468714, 6932.202796678345, 7096.751613693599, 7150.034745309421, 6693.966530167416, 6713.496487763339, 6851.897221541681, 6868.450523958071, 6870.175578930561, 3957.3866050762176, 3982.6415622593527, 4053.5135783706146, 4148.23257697327, 4175.707700460999, 1677.653082101216, 1791.480470663493, 1820.3173809821317, 1823.340759908477, 1824.252056656791, 792.8731402975496, 824.7154731617583, 831.8502669519545, 832.508819796311, 856.3577317012241, 15861.603459913595, 15894.602634933988, 16126.75809862853, 16158.0, 16425.91787041081, 799.9240072193132, 811.4603788480712, 822.8066404394963, 826.3348004856028, 847.1740053447962, 9024.413413128257, 9056.184943355129, 9135.177833994972, 9315.0, 9426.434413935185, 247000.0, 325013.0, 325779.0, 325999.0, 326044.0, 62306.0, 70204.0, 71381.64309178421, 71625.64187179031, 71843.0, 985.7732721474101, 1009.5860697114148, 1013.5185786751234, 1017.3844823881593, 1026.3174988632475, 14747.0, 14980.325885334969, 14981.925090374914, 15144.54566363011, 15272.618184545476, 33381.0, 33510.0, 34204.828975855955, 34371.0, 34633.826830865684, 44444.55555444534, 45470.54529454663, 45810.54189458063, 45992.310115347624, 46004.0, 6856.691448884912, 7151.713931442892, 7184.8922266165, 7342.339189472973, 7371.152317483344, 10713.517891694737, 10998.890011099787, 11270.267432616854, 11389.658310250374, 11555.422228888354, 9256.95371523138, 9304.30217733659, 9497.47763872966, 9819.45992970365, 9896.406215627085, 9455.669051583161, 9731.513424328898, 9774.218062555121, 9827.459489728133, 9942.453165075991, 5541.722913854372, 5688.63023903445, 9214.769630759285, 9488.430694158373, 9944.801103977736, 7665.770026899202, 7678.232176782277, 7723.459357845121, 7796.259355361231, 7801.804954875946, 8579.184977427134, 10011.59837622748, 10181.898181018096, 10254.230932680228, 10280.126189273995], "value": 7744.5142693572825, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1323.4639970811818, 1329.4283458113011, 1330.2484096485484, 1332.9600111996645, 1334.6996925691717, 6665.833354166149, 6802.319768023195, 7036.73338799016, 7441.51630144041, 7453.590052547108, 7019.087518622585, 7268.491205615609, 7303.0, 7446.925530744691, 7512.211217822119, 2100.2019232691555, 2145.313499680095, 2148.495103650641, 2150.311900191939, 2154.149111101114, 2084.8637492566513, 2149.0973791007737, 2177.7822217778175, 2188.8686678799245, 2207.834412419067, 2204.0522575292616, 2224.8331375146927, 2228.108756497406, 2231.7545070042283, 2233.7319521657423, 2090.581883623274, 2096.9475763105893, 2097.0, 2102.180149741602, 2113.9048742806535, 2112.0706888968803, 2114.3551216878845, 2140.9464763380884, 2142.678598210281, 2159.287435146398, 7399.70401183952, 7466.6266686665995, 7538.020057392559, 7556.2443755624545, 7556.848863022708, 4417.138657961698, 4525.683202175849, 4540.8864778380475, 4559.954400455986, 4577.0159415725775, 2856.657201135877, 2936.163193489845, 3016.75865930725, 3029.681883402233, 3130.5930229070077, 1101.3942331717524, 1143.7369405036804, 1148.3970915269467, 1176.1061593189152, 1188.518649946773, 9569.425834449956, 9618.9519052405, 9662.75843103921, 9676.75808104796, 9677.580604848788, 3781.773093614392, 3980.7412518186225, 4005.4792876925812, 4038.7172897897453, 4079.6124368184974, 7798.922010779933, 7821.217878212247, 7837.7648670539975, 7843.764687059397, 7849.568273744999, 4442.20040392726, 4443.133588950188, 4457.197704413172, 4463.218936686067, 4463.709858859163, 4028.315186418316, 4100.91798164041, 4108.609682080198, 4115.032967252693, 4116.361963895601, 3196.9840150799564, 3240.659730728287, 3326.085326535174, 3332.0, 3336.6996970272307, 925.1858364639209, 933.9486328251876, 1004.1715584642699, 1022.7392015036266, 1106.994465027686, 688.90355350251, 697.7488104282454, 701.9543729657556, 716.3266529462289, 721.8592374486925, 4620.861374158781, 4778.211595086772, 4792.7124372537755, 4829.855104346875, 4906.11689895815, 837.7495318165601, 859.6174702257435, 860.1484530315068, 871.8525380320891, 892.3797960417447, 3329.3674201901563, 3364.192593777476, 3384.6953774160443, 3403.7617366784584, 3461.1001139703353, 8708.91291087081, 8796.604152813139, 8890.64437422496, 8892.021877593459, 8896.644134234559, 8841.248493878093, 8844.292456603456, 8845.690400836069, 8846.424982376253, 8899.15458031486, 6538.0, 6792.490563207779, 6902.344277293549, 6925.376716095576, 7054.08296921397, 4781.521847815191, 4885.633577481632, 5004.17431123875, 5050.545450909436, 5096.796128154981, 7837.529748214897, 7933.294341716559, 8165.979252593425, 8198.672053117809, 8226.341892648694, 8263.834723305621, 8288.70989515364, 8293.0, 8336.374771892253, 8444.451110677786, 7023.543469674659, 7112.324329188718, 7115.181754098345, 7116.50184487081, 7139.500234983501, 7043.7534686285735, 7078.362947334765, 7128.037714908421, 7131.2155662876, 7141.535800172972, 6409.391107844747, 6479.157709497735, 6510.7721229756735, 6528.347165283433, 6535.542512024303, 6343.175387199634, 6398.616083035033, 6443.7744678936015, 6458.321876202931, 6461.127747754181, 5647.463490968352, 5671.291088613923, 5676.545876329967, 5682.687452190169, 5706.4864162225595, 4114.280000999754, 4145.0, 4202.579742025773, 4224.978875105605, 4300.849470268526, 4322.9135417290845, 4379.956200438082, 4388.51726310112, 4455.844045458393, 4556.635469162526], "value": 3935.0842375521634, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.87631014679636, 350.0967503840092, 353.466265938433, 355.31424351002585, 360.80696827197437, 4899.877503062421, 4921.458639549646, 4946.5795407390415, 4957.727324997124, 4958.256261560768, 4915.926261106087, 4925.591595522014, 4937.210046392578, 4946.978816501254, 4950.480199579047, 3711.536057992751, 3848.2111167210655, 3867.1298957734566, 3893.357595996657, 3983.800809959505, 3828.483154774098, 3838.9040273993096, 3846.903827404309, 3874.321993651114, 3879.243547508237, 3809.1810260793923, 3815.751976121543, 3826.445165451008, 3840.0, 3844.2695887781374, 3667.2482141161263, 3820.331441997639, 3842.5196850393563, 3844.807759612036, 3849.8075096245075, 3303.0586282909258, 3310.7682462227654, 3314.0, 3321.9003429897143, 3328.267781088157, 4790.353302304179, 4808.158572249842, 4809.95190048102, 4814.181589129857, 4844.757762111915, 4351.108022855307, 4372.256716358195, 4375.7155784873885, 4385.51759306476, 4418.955810441887, 5004.524570165829, 5141.794328226866, 5157.58739300855, 5194.792208311663, 5222.582193424555, 3652.433872749728, 3653.2328211075705, 3654.1230104774663, 3662.926741465182, 3682.668559829628, 5369.301990741218, 5378.327709036371, 5396.163594642837, 5420.13277875542, 5459.645123066988, 3644.325799727059, 3719.739618226752, 3734.2718169956597, 3737.7944213068, 3751.362268414376, 3736.1967177057063, 3746.250749850041, 3789.3368660484307, 3792.1278106035215, 3798.4112462568346, 4296.550965949379, 4309.0, 4309.547497512779, 4313.84901528445, 4353.107612939403, 5058.671186372874, 5136.712503997444, 5172.844814655567, 5183.688978661293, 5189.091908916, 1275.79587266037, 1279.411470723459, 1283.153118941494, 1285.8264134341932, 1286.3761075878192, 859.4971941414218, 868.7133246028795, 881.7487016200353, 884.7434244069276, 885.4510203673764, 4439.66702497314, 4456.309272062836, 4572.725636461823, 4584.266517357207, 4647.790849411717, 5274.630775845654, 5356.232443293781, 5360.437154098763, 5367.651102678314, 5388.003219404422, 4572.702774319659, 4599.195140850338, 4604.286335617984, 4606.147862645421, 4625.283081122431, 2696.8651567421552, 2748.2717079973822, 2755.4489102179646, 2795.203367040384, 2801.6918139004692, 4841.3222148899185, 4897.877553061202, 4921.45655128307, 4923.433805112386, 4962.950370496249, 5155.407128180233, 5333.200019996954, 5335.546478549367, 5385.219143224289, 5402.648827826179, 4854.499932534818, 4856.878578035577, 4873.780679869415, 4904.969956309215, 4927.876803079952, 5254.7898084076205, 5256.579473642176, 5262.473752624707, 5282.6038047147385, 5294.97352513235, 4965.205567109245, 5183.641443143285, 5202.505761952609, 5212.478752124757, 5217.330454254602, 4964.900701986012, 5003.34956455673, 5004.424491183415, 5022.84931452057, 5027.949720502748, 3712.3317802795755, 3718.665320121202, 3747.2880152770886, 3750.2810462415623, 3763.6424539668687, 5192.480751924777, 5425.457454254543, 5428.45715428454, 5430.67415955044, 5441.238226648194, 5153.278541004187, 5170.560502357342, 5183.611229157753, 5197.324347834758, 5201.843944681666, 5185.611079169153, 5193.143131383279, 5201.1678131498775, 5202.947970520247, 5214.243934629533, 4980.676256043345, 5125.129927240757, 5142.408623008252, 5143.434222235476, 5190.714510701948, 4921.753912304442, 5069.898602028013, 5143.0, 5160.200168973815, 5165.251038599457, 5006.524380183877, 5069.340985671839, 5081.745912704424, 5081.900040975076, 5111.667741596784], "value": 3892.9191908060225, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [676.1784431915222, 682.0791930893298, 736.3851184261142, 750.504666919833, 761.2729842999934, 14260.857391426083, 14678.706425871489, 14734.778978315333, 15376.923115384407, 15464.536063918073, 14743.48397806077, 14798.630034249149, 14950.775738363933, 14953.177575233358, 14959.626009349771, 675.4461341699808, 787.5117427195119, 787.9566623835686, 795.252462685077, 795.6340083561569, 684.9726010959556, 807.3541167066353, 818.8894499242585, 826.9503829770202, 829.3531045784267, 856.3448961544424, 860.1312674199041, 861.2033868671485, 861.4745005546612, 865.809521905183, 848.9363297752693, 851.9744407667749, 853.185208126241, 853.7140058080488, 855.0850589868843, 621.7140115546854, 625.8435391152212, 627.4572494791972, 627.4948666323608, 628.7170773152054, 12983.415746291439, 13208.207507549578, 13270.86729132706, 13275.60173194796, 13760.862391376058, 12612.68468288291, 13167.67080822987, 13174.407151678197, 13339.33303334839, 13615.387307571184, 10287.736697926444, 10376.584936602527, 10496.527656255486, 10705.732356691145, 10819.83770243447, 3218.5815843940372, 3241.38413701396, 3264.9020529384156, 3297.670232976707, 3312.0560640217423, 59739.10391344134, 59798.0, 60723.392766072655, 60739.39260607426, 62387.0, 9926.2059035277, 10022.649207277711, 10130.746731331776, 10232.33489823174, 10376.42929638862, 18478.260869565336, 18567.907160464383, 18626.627467450846, 18655.0, 18659.90670046641, 5916.408359164049, 5959.702014899238, 6171.9691401542705, 6182.319944806068, 6246.094316324107, 3575.3385623659706, 3623.1847834237087, 3641.5812181599454, 3649.9635003649623, 3652.872149474809, 2867.5411934090444, 2931.3404483991358, 2936.427396657631, 2946.2634341414646, 2970.301979034925, 455.5057762327845, 456.4157877916272, 464.0487001646611, 467.09616891315414, 471.1848502091401, 623.2645478335517, 640.1230314469113, 640.6284355074046, 645.3578689204272, 649.2079662811362, 7470.663820128108, 7564.773056808304, 8052.6713092339105, 8232.670693172206, 8517.23344898962, 611.4222060153113, 624.2820756130486, 625.9311475737666, 626.2141013028711, 635.6821589205397, 3888.1282616028643, 4022.2960981828646, 4035.6973227007506, 4078.9184216316103, 4138.772367519755, 53496.73251633717, 63264.367356326766, 64794.0, 64899.35100649027, 65301.67349163224, 52742.47257527452, 55124.72437637866, 55259.44740552623, 55278.72360638171, 55443.445565544636, 40054.39918401226, 42823.571764282584, 45993.31010034785, 48741.26888096681, 48974.02051958941, 8438.818565400727, 8755.693550725695, 8976.506292153994, 9283.72148835536, 9285.907140928504, 31162.0, 31723.20691982719, 32602.83698581587, 32801.343973119925, 33858.0, 37335.81332093322, 39782.403263951644, 39981.2003759929, 40051.198976020896, 41185.79407102945, 10454.215933805148, 10760.0, 10819.0, 10887.727806804893, 10894.128469722245, 11439.256448330832, 11591.76816463683, 11603.045812008488, 11701.239419437708, 11839.585614503796, 11899.762004759683, 11957.342346170695, 12123.151379403356, 12197.69505762363, 12337.259764414164, 11398.715032123931, 11410.486528106088, 11603.419829008684, 11683.591074312359, 11731.530738770694, 11817.290962542274, 12030.15788894769, 12370.0, 12799.488020479077, 12909.419076141408, 9361.625534978797, 9509.334346595948, 9552.42685438876, 9597.712068637951, 9864.260180486348, 9043.909560904307, 9170.908290917272, 10097.343672661253, 10355.119814815826, 10444.42555659446], "value": 6246.033398452032, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1581.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 116.0, 116.0, 116.0, 115.0, 115.0, 116.0, 115.0, 116.0, 115.0], "value": 114.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 130.0, 133.0, 168.0, 136.0, 127.0, 137.0, 128.0, 152.0, 131.0], "value": 139.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 166.0, 166.0, 163.0, 166.0, 166.0, 163.0, 162.0, 163.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 75.0, 112.0, 79.0, 77.0, 78.0, 79.0, 105.0, 77.0], "value": 83.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 107.0, 85.0, 85.0, 86.0, 99.0, 85.0, 87.0, 106.0], "value": 90.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 119.0, 119.0, 119.0, 118.0, 118.0, 117.0, 118.0], "value": 118.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 150.0, 153.0, 151.0, 151.0, 150.0, 151.0, 151.0, 151.0], "value": 150.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 95.0, 95.0, 96.0], "value": 96.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 63.0, 64.0, 64.0, 65.0, 65.0, 65.0, 64.0, 66.0, 68.0], "value": 65.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 70.0, 68.0, 68.0, 68.0, 68.0, 71.0, 69.0, 68.0, 73.0], "value": 69.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 86.0, 96.0, 87.0, 96.0, 87.0, 87.0, 85.0, 86.0], "value": 88.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 146.0, 137.0, 147.0, 137.0, 137.0, 151.0, 134.0, 208.0, 135.0], "value": 147.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 179.0, 176.0, 176.0, 178.0, 182.0, 186.0, 181.0, 192.0, 181.0], "value": 181.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 71.0, 71.0, 70.0, 75.0, 72.0, 70.0, 69.0, 70.0], "value": 71.0, "unit": "score"}]}]} 07:56:39 INFO - Return code: 0 07:56:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:56:39 ERROR - # TBPL SUCCESS # 07:56:39 INFO - Running post-action listener: _resource_record_post_action 07:56:39 INFO - [mozharness: 2017-01-02 15:56:39.725267Z] Finished run-tests step (success) 07:56:39 INFO - Running post-run listener: _resource_record_post_run 07:56:39 INFO - Total resource usage - Wall time: 1201s; CPU: 14.0%; Read bytes: 0; Write bytes: 394203136; Read time: 0; Write time: 364772 07:56:39 INFO - TinderboxPrint: CPU usage
13.5% 07:56:39 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 07:56:39 INFO - TinderboxPrint: I/O write bytes / time
394,203,136 / 364,772 07:56:39 INFO - TinderboxPrint: CPU idle
8,287.3 (86.5%) 07:56:39 INFO - TinderboxPrint: CPU user
1,233.2 (12.9%) 07:56:39 INFO - TinderboxPrint: Swap in / out
0 / 0 07:56:39 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 111398912; Read time: 0; Write time: 80740 07:56:39 INFO - run-tests - Wall time: 1185s; CPU: 14.0%; Read bytes: 0; Write bytes: 282468352; Read time: 0; Write time: 284028 07:56:40 INFO - Running post-run listener: _upload_blobber_files 07:56:40 INFO - Blob upload gear active. 07:56:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:56:40 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 07:56:40 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:56:40 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:56:40 INFO - (blobuploader) - INFO - Open directory for files ... 07:56:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:56:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:56:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:56:41 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:56:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:56:41 INFO - (blobuploader) - INFO - Done attempting. 07:56:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:56:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:56:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:56:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:56:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:56:42 INFO - (blobuploader) - INFO - Done attempting. 07:56:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:56:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:56:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:56:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:56:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:56:43 INFO - (blobuploader) - INFO - Done attempting. 07:56:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:56:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:56:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:56:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:56:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:56:46 INFO - (blobuploader) - INFO - Done attempting. 07:56:46 INFO - (blobuploader) - INFO - Iteration through files over. 07:56:46 INFO - Return code: 0 07:56:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:56:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:56:46 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/76f2e880f7229838efbcdcefaeb21d340018bd554d1dbf999751f71b2765c95a2faf3edba71f11c6ba880ffe1d64ff1c32af7bf97fa78c1be38917eb4ed7559f", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d65cf0d2f91d265051b1032e73730978b6922591d2125450616e4ba4747a9a8a5938a226f5b95b24a84a8d29e70f51525ecf009eda7cdd92adc2a56c45580e5d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a1c22e3714071cc1a8b379029f2c7ba8808fa692445a77636404372d67b9fe231159ce098dde8ff7803c888b35327172da00c4253f5af98e58c50e90b20ec1e3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/958e82264a593b3bab063b0a7053af77e0303d43ec373301a7e5640dcb08b5a5ebd62774301d429fc687313f65e83b6ff8cb7ad1d07c264d2e257037616a26b8"} 07:56:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:56:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:56:46 INFO - Contents: 07:56:46 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/76f2e880f7229838efbcdcefaeb21d340018bd554d1dbf999751f71b2765c95a2faf3edba71f11c6ba880ffe1d64ff1c32af7bf97fa78c1be38917eb4ed7559f", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d65cf0d2f91d265051b1032e73730978b6922591d2125450616e4ba4747a9a8a5938a226f5b95b24a84a8d29e70f51525ecf009eda7cdd92adc2a56c45580e5d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a1c22e3714071cc1a8b379029f2c7ba8808fa692445a77636404372d67b9fe231159ce098dde8ff7803c888b35327172da00c4253f5af98e58c50e90b20ec1e3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/958e82264a593b3bab063b0a7053af77e0303d43ec373301a7e5640dcb08b5a5ebd62774301d429fc687313f65e83b6ff8cb7ad1d07c264d2e257037616a26b8"} 07:56:46 INFO - Running post-run listener: copy_logs_to_upload_dir 07:56:46 INFO - Copying logs to upload dir... 07:56:46 INFO - mkdir: /builds/slave/test/build/upload/logs 07:56:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.245720 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-01-02 07:56:44.996282) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-02 07:56:44.999942) ========= 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=ba164b0a7b0ec7655860e956000001c1-1483371188.653610-372016290 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/76f2e880f7229838efbcdcefaeb21d340018bd554d1dbf999751f71b2765c95a2faf3edba71f11c6ba880ffe1d64ff1c32af7bf97fa78c1be38917eb4ed7559f", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d65cf0d2f91d265051b1032e73730978b6922591d2125450616e4ba4747a9a8a5938a226f5b95b24a84a8d29e70f51525ecf009eda7cdd92adc2a56c45580e5d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a1c22e3714071cc1a8b379029f2c7ba8808fa692445a77636404372d67b9fe231159ce098dde8ff7803c888b35327172da00c4253f5af98e58c50e90b20ec1e3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/958e82264a593b3bab063b0a7053af77e0303d43ec373301a7e5640dcb08b5a5ebd62774301d429fc687313f65e83b6ff8cb7ad1d07c264d2e257037616a26b8"} build_url:https://queue.taskcluster.net/v1/task/JsEJES8QQ3yOsvS55PSnqg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011480 build_url: 'https://queue.taskcluster.net/v1/task/JsEJES8QQ3yOsvS55PSnqg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/76f2e880f7229838efbcdcefaeb21d340018bd554d1dbf999751f71b2765c95a2faf3edba71f11c6ba880ffe1d64ff1c32af7bf97fa78c1be38917eb4ed7559f", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d65cf0d2f91d265051b1032e73730978b6922591d2125450616e4ba4747a9a8a5938a226f5b95b24a84a8d29e70f51525ecf009eda7cdd92adc2a56c45580e5d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a1c22e3714071cc1a8b379029f2c7ba8808fa692445a77636404372d67b9fe231159ce098dde8ff7803c888b35327172da00c4253f5af98e58c50e90b20ec1e3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/958e82264a593b3bab063b0a7053af77e0303d43ec373301a7e5640dcb08b5a5ebd62774301d429fc687313f65e83b6ff8cb7ad1d07c264d2e257037616a26b8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-02 07:56:45.025350) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-02 07:56:45.025684) ========= 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=ba164b0a7b0ec7655860e956000001c1-1483371188.653610-372016290 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004532 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-02 07:56:45.110399) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-02 07:56:45.110731) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-02 07:56:45.111008) ========= ========= Total master_lag: 0.15 =========