builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-007 starttime: 1493092058.1 results: success (0) revision: f0621f7f0520476b10eda7b4a59cb976b1e1f2b9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-24 20:47:38.103806) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-24 20:47:38.104394) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-24 20:47:38.104712) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-24 20:47:38.120282) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 20:47:38.120660) ========= 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=923d835db2ba3686ebe126b700000192-1493089496.422526-2033550201 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-04-24 20:47:38-- 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% 48.9K=0.2s 2017-04-24 20:47:39 (48.9 KB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.391250 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 20:47:38.527447) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 20:47:38.527830) ========= 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=923d835db2ba3686ebe126b700000192-1493089496.422526-2033550201 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016758 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 20:47:38.578297) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-24 20:47:38.578673) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f0621f7f0520476b10eda7b4a59cb976b1e1f2b9 --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 f0621f7f0520476b10eda7b4a59cb976b1e1f2b9 --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=923d835db2ba3686ebe126b700000192-1493089496.422526-2033550201 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-04-24 20:47:39,272 truncating revision to first 12 chars 2017-04-24 20:47:39,272 Setting DEBUG logging. 2017-04-24 20:47:39,272 attempt 1/10 2017-04-24 20:47:39,272 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f0621f7f0520?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-24 20:47:40,634 unpacking tar archive at: mozilla-central-f0621f7f0520/testing/mozharness/ program finished with exit code 0 elapsedTime=1.687224 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-24 20:47:40.280390) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-24 20:47:40.280769) ========= script_repo_revision: f0621f7f0520476b10eda7b4a59cb976b1e1f2b9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-24 20:47:40.281292) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-24 20:47:40.281595) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-24 20:47:40.292922) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 2 secs) (at 2017-04-24 20:47:40.293425) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=923d835db2ba3686ebe126b700000192-1493089496.422526-2033550201 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:47:41 INFO - MultiFileLogger online at 20170424 20:47:41 in /builds/slave/test 20:47:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 20:47:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:47:41 INFO - {'append_to_log': False, 20:47:41 INFO - 'base_work_dir': '/builds/slave/test', 20:47:41 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 20:47:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:47:41 INFO - 'branch': 'Firefox-Non-PGO', 20:47:41 INFO - 'buildbot_json_path': 'buildprops.json', 20:47:41 INFO - 'config_files': ('talos/linux_config.py',), 20:47:41 INFO - 'default_actions': ('clobber', 20:47:41 INFO - 'read-buildbot-config', 20:47:41 INFO - 'download-and-extract', 20:47:41 INFO - 'populate-webroot', 20:47:41 INFO - 'create-virtualenv', 20:47:41 INFO - 'install', 20:47:41 INFO - 'run-tests'), 20:47:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:47:41 INFO - 'download_minidump_stackwalk': True, 20:47:41 INFO - 'download_symbols': 'ondemand', 20:47:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:47:41 INFO - 'tooltool.py': '/tools/tooltool.py', 20:47:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:47:41 INFO - '/tools/misc-python/virtualenv.py')}, 20:47:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:47:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:47:41 INFO - 'gecko_profile': False, 20:47:41 INFO - 'gecko_profile_interval': 0, 20:47:41 INFO - 'installer_path': 'installer.exe', 20:47:41 INFO - 'log_level': 'info', 20:47:41 INFO - 'log_name': 'talos', 20:47:41 INFO - 'log_to_console': True, 20:47:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:47:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:47:41 INFO - 'opt_config_files': (), 20:47:41 INFO - 'pip_index': False, 20:47:41 INFO - 'suite': 'dromaeojs', 20:47:41 INFO - 'system_bits': '32', 20:47:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:47:41 INFO - 'title': 'talos-linux64-ix-007', 20:47:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:47:41 INFO - 'use_talos_json': True, 20:47:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:47:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:47:41 INFO - 'work_dir': 'build'} 20:47:41 INFO - [mozharness: 2017-04-25 03:47:41.081436Z] Running clobber step. 20:47:41 INFO - Running pre-action listener: _resource_record_pre_action 20:47:41 INFO - Running main action method: clobber 20:47:41 INFO - rmtree: /builds/slave/test/build 20:47:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:47:42 INFO - Running post-action listener: _resource_record_post_action 20:47:42 INFO - [mozharness: 2017-04-25 03:47:42.030036Z] Finished clobber step (success) 20:47:42 INFO - [mozharness: 2017-04-25 03:47:42.030134Z] Running read-buildbot-config step. 20:47:42 INFO - Running pre-action listener: _resource_record_pre_action 20:47:42 INFO - Running main action method: read_buildbot_config 20:47:42 INFO - Using buildbot properties: 20:47:42 INFO - { 20:47:42 INFO - "project": "", 20:47:42 INFO - "product": "firefox", 20:47:42 INFO - "who": "ihsiao@mozilla.com", 20:47:42 INFO - "installer_path": "public/build/target.tar.bz2", 20:47:42 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 20:47:42 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 20:47:42 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 20:47:42 INFO - "stage_platform": "linux64", 20:47:42 INFO - "basedir": "/builds/slave/test", 20:47:42 INFO - "buildnumber": 562, 20:47:42 INFO - "platform": "ubuntu64_hw", 20:47:42 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 20:47:42 INFO - "slavebuilddir": "test", 20:47:42 INFO - "taskId": "ENoKk90_Tmid35OIxSqnMw", 20:47:42 INFO - "branch": "mozilla-central", 20:47:42 INFO - "script_repo_revision": "production", 20:47:42 INFO - "revision": "f0621f7f0520476b10eda7b4a59cb976b1e1f2b9", 20:47:42 INFO - "slavename": "talos-linux64-ix-007", 20:47:42 INFO - "repo_path": "mozilla-central" 20:47:42 INFO - } 20:47:42 INFO - Finding installer, test and symbols from parent task. 20:47:42 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ENoKk90_Tmid35OIxSqnMw'}, attempt #1 20:47:42 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ENoKk90_Tmid35OIxSqnMw'}, attempt #1 20:47:42 INFO - Task dependencies: JqbWFgNnSc2wFIq8kjQJ2w 20:47:42 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JqbWFgNnSc2wFIq8kjQJ2w'}, attempt #1 20:47:43 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/JqbWFgNnSc2wFIq8kjQJ2w/artifacts/public/build/target.tar.bz2 20:47:43 INFO - Set test_url: https://queue.taskcluster.net/v1/task/JqbWFgNnSc2wFIq8kjQJ2w/artifacts/public/build/test_packages.json 20:47:43 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/JqbWFgNnSc2wFIq8kjQJ2w/artifacts/public/build/target.crashreporter-symbols.zip 20:47:43 INFO - Running post-action listener: _resource_record_post_action 20:47:43 INFO - [mozharness: 2017-04-25 03:47:43.371790Z] Finished read-buildbot-config step (success) 20:47:43 INFO - [mozharness: 2017-04-25 03:47:43.372008Z] Running download-and-extract step. 20:47:43 INFO - Running pre-action listener: _resource_record_pre_action 20:47:43 INFO - Running main action method: download_and_extract 20:47:43 INFO - mkdir: /builds/slave/test/build/tests 20:47:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:47:43 INFO - trying https://queue.taskcluster.net/v1/task/JqbWFgNnSc2wFIq8kjQJ2w/artifacts/public/build/target.test_packages.json 20:47:43 INFO - Downloading https://queue.taskcluster.net/v1/task/JqbWFgNnSc2wFIq8kjQJ2w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 20:47:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JqbWFgNnSc2wFIq8kjQJ2w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 20:47:43 INFO - Downloaded 986 bytes. 20:47:44 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 20:47:44 INFO - Using the following test package requirements: 20:47:44 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 20:47:44 INFO - u'common': [u'target.common.tests.zip'], 20:47:44 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 20:47:44 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 20:47:44 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 20:47:44 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 20:47:44 INFO - u'mozbase': [u'target.common.tests.zip'], 20:47:44 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 20:47:44 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 20:47:44 INFO - u'web-platform': [u'target.common.tests.zip', 20:47:44 INFO - u'target.web-platform.tests.zip'], 20:47:44 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 20:47:44 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 20:47:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JqbWFgNnSc2wFIq8kjQJ2w/artifacts/public/build/target.common.tests.zip 20:47:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JqbWFgNnSc2wFIq8kjQJ2w/artifacts/public/build/target.common.tests.zip'}, attempt #1 20:47:44 INFO - Fetch https://queue.taskcluster.net/v1/task/JqbWFgNnSc2wFIq8kjQJ2w/artifacts/public/build/target.common.tests.zip into memory 20:47:45 INFO - Content-Length response header: 58260199 20:47:45 INFO - Bytes received: 58260199 20:47:54 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 20:47:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JqbWFgNnSc2wFIq8kjQJ2w/artifacts/public/build/target.common.tests.zip 20:47:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JqbWFgNnSc2wFIq8kjQJ2w/artifacts/public/build/target.common.tests.zip'}, attempt #1 20:47:54 INFO - Fetch https://queue.taskcluster.net/v1/task/JqbWFgNnSc2wFIq8kjQJ2w/artifacts/public/build/target.common.tests.zip into memory 20:47:56 INFO - Content-Length response header: 58260199 20:47:56 INFO - Bytes received: 58260199 20:48:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JqbWFgNnSc2wFIq8kjQJ2w/artifacts/public/build/target.talos.tests.zip 20:48:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JqbWFgNnSc2wFIq8kjQJ2w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 20:48:06 INFO - Fetch https://queue.taskcluster.net/v1/task/JqbWFgNnSc2wFIq8kjQJ2w/artifacts/public/build/target.talos.tests.zip into memory 20:48:07 INFO - Content-Length response header: 14408822 20:48:07 INFO - Bytes received: 14408822 20:48:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:48:07 INFO - trying https://queue.taskcluster.net/v1/task/JqbWFgNnSc2wFIq8kjQJ2w/artifacts/public/build/target.tar.bz2 20:48:07 INFO - Downloading https://queue.taskcluster.net/v1/task/JqbWFgNnSc2wFIq8kjQJ2w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 20:48:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JqbWFgNnSc2wFIq8kjQJ2w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 20:48:09 INFO - Downloaded 58400102 bytes. 20:48:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JqbWFgNnSc2wFIq8kjQJ2w/artifacts/public/build/target.tar.bz2 20:48:09 INFO - mkdir: /builds/slave/test/properties 20:48:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:48:09 INFO - Writing to file /builds/slave/test/properties/build_url 20:48:09 INFO - Contents: 20:48:09 INFO - build_url:https://queue.taskcluster.net/v1/task/JqbWFgNnSc2wFIq8kjQJ2w/artifacts/public/build/target.tar.bz2 20:48:09 INFO - Running post-action listener: _resource_record_post_action 20:48:09 INFO - Running post-action listener: set_extra_try_arguments 20:48:09 INFO - [mozharness: 2017-04-25 03:48:09.554298Z] Finished download-and-extract step (success) 20:48:09 INFO - [mozharness: 2017-04-25 03:48:09.554505Z] Running populate-webroot step. 20:48:09 INFO - Running pre-action listener: _resource_record_pre_action 20:48:09 INFO - Running main action method: populate_webroot 20:48:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:48:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:48:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:48:09 INFO - '--tppagecycles', 20:48:09 INFO - '7'], 20:48:09 INFO - 'tests': ['tsvgm']}}, 20:48:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:48:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:48:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:48:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:48:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:48:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:48:09 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 20:48:09 INFO - 'talos_options': ['--disable-e10s'], 20:48:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:48:09 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 20:48:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:48:09 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 20:48:09 INFO - 'talos_options': ['--disable-e10s'], 20:48:09 INFO - 'tests': ['damp', 'tps']}, 20:48:09 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 20:48:09 INFO - 'tests': ['damp', 'tps']}, 20:48:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:48:09 INFO - 'tests': ['dromaeo_dom']}, 20:48:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:48:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:48:09 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 20:48:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 20:48:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:48:09 INFO - 'tests': ['a11yr', 20:48:09 INFO - 'ts_paint', 20:48:09 INFO - 'tpaint', 20:48:09 INFO - 'sessionrestore', 20:48:09 INFO - 'sessionrestore_no_auto_restore', 20:48:09 INFO - 'tabpaint']}, 20:48:09 INFO - 'other-e10s': {'tests': ['a11yr', 20:48:09 INFO - 'ts_paint', 20:48:09 INFO - 'tpaint', 20:48:09 INFO - 'sessionrestore', 20:48:09 INFO - 'sessionrestore_no_auto_restore', 20:48:09 INFO - 'tabpaint']}, 20:48:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:48:09 INFO - 'ts_paint', 20:48:09 INFO - 'tpaint', 20:48:09 INFO - 'sessionrestore', 20:48:09 INFO - 'sessionrestore_no_auto_restore', 20:48:09 INFO - 'tabpaint']}, 20:48:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:48:09 INFO - 'ts_paint', 20:48:09 INFO - 'tpaint', 20:48:09 INFO - 'sessionrestore', 20:48:09 INFO - 'sessionrestore_no_auto_restore', 20:48:09 INFO - 'tabpaint']}, 20:48:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:48:09 INFO - 'tests': ['a11yr', 20:48:09 INFO - 'ts_paint', 20:48:09 INFO - 'tpaint', 20:48:09 INFO - 'sessionrestore', 20:48:09 INFO - 'sessionrestore_no_auto_restore', 20:48:09 INFO - 'tabpaint']}, 20:48:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:48:09 INFO - 'tests': ['a11yr', 20:48:09 INFO - 'ts_paint', 20:48:09 INFO - 'tpaint', 20:48:09 INFO - 'sessionrestore', 20:48:09 INFO - 'sessionrestore_no_auto_restore', 20:48:09 INFO - 'tabpaint']}, 20:48:09 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 20:48:09 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 20:48:09 INFO - 'bloom_basic_ref']}, 20:48:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:48:09 INFO - 'tests': ['tsvgx', 20:48:09 INFO - 'tsvgr_opacity', 20:48:09 INFO - 'tart', 20:48:09 INFO - 'tscrollx', 20:48:09 INFO - 'cart', 20:48:09 INFO - 'tsvg_static']}, 20:48:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:48:09 INFO - 'tsvgr_opacity', 20:48:09 INFO - 'tart', 20:48:09 INFO - 'tscrollx', 20:48:09 INFO - 'cart', 20:48:09 INFO - 'tsvg_static']}, 20:48:09 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 20:48:09 INFO - 'talos_options': ['--disable-e10s'], 20:48:09 INFO - 'tests': ['tp5o']}, 20:48:09 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 20:48:09 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 20:48:09 INFO - 'talos_options': ['--disable-e10s', 20:48:09 INFO - '--xperf_path', 20:48:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:48:09 INFO - 'tests': ['tp5n']}, 20:48:09 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 20:48:09 INFO - 'talos_options': ['--xperf_path', 20:48:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:48:09 INFO - 'tests': ['tp5n']}}, 20:48:09 INFO - 'talos.zip': {'path': '', 20:48:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:48:09 INFO - Running post-action listener: _resource_record_post_action 20:48:09 INFO - [mozharness: 2017-04-25 03:48:09.572426Z] Finished populate-webroot step (success) 20:48:09 INFO - [mozharness: 2017-04-25 03:48:09.572514Z] Running create-virtualenv step. 20:48:09 INFO - Running pre-action listener: _resource_record_pre_action 20:48:09 INFO - Running main action method: create_virtualenv 20:48:09 INFO - Creating virtualenv /builds/slave/test/build/venv 20:48:09 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 20:48:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:48:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:48:09 INFO - Using real prefix '/usr' 20:48:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:48:10 INFO - Installing distribute.............................................................................................................................................................................................done. 20:48:12 INFO - Installing pip.................done. 20:48:12 INFO - Return code: 0 20:48:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:48:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:48:12 INFO - Reading from file tmpfile_stdout 20:48:12 INFO - Output received: 20:48:12 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) 20:48:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:48:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:48:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:48:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:48:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:48:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:48:12 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 0x21c81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2465b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2463290>, '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 0x2463b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2464040>, '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': '923d835db2ba3686ebe126b700000192-1493089496.422526-2033550201', '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 20:48:12 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 20:48:12 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 20:48:12 INFO - Using env: {'DISPLAY': ':0', 20:48:12 INFO - 'HOME': '/home/cltbld', 20:48:12 INFO - 'LANG': 'en_US.UTF-8', 20:48:12 INFO - 'LANGUAGE': 'en_US:en', 20:48:12 INFO - 'LOGNAME': 'cltbld', 20:48:12 INFO - 'MAIL': '/var/mail/cltbld', 20:48:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:48:12 INFO - 'MOZ_NO_REMOTE': '1', 20:48:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:48:12 INFO - 'NO_EM_RESTART': '1', 20:48:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:48:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:48:12 INFO - 'PWD': '/builds/slave/test', 20:48:12 INFO - 'SHELL': '/bin/bash', 20:48:12 INFO - 'SHLVL': '1', 20:48:12 INFO - 'TERM': 'linux', 20:48:12 INFO - 'TMOUT': '86400', 20:48:12 INFO - 'USER': 'cltbld', 20:48:12 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1493089496.422526-2033550201', 20:48:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:48:12 INFO - '_': '/tools/buildbot/bin/python'} 20:48:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:48:12 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 20:48:12 INFO - Cleaning up... 20:48:12 INFO - Return code: 0 20:48:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:48:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:48:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:48:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:48:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:48:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:48:12 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 0x21c81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2465b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2463290>, '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 0x2463b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2464040>, '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': '923d835db2ba3686ebe126b700000192-1493089496.422526-2033550201', '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 20:48:12 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 20:48:12 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 20:48:12 INFO - Using env: {'DISPLAY': ':0', 20:48:12 INFO - 'HOME': '/home/cltbld', 20:48:12 INFO - 'LANG': 'en_US.UTF-8', 20:48:12 INFO - 'LANGUAGE': 'en_US:en', 20:48:12 INFO - 'LOGNAME': 'cltbld', 20:48:12 INFO - 'MAIL': '/var/mail/cltbld', 20:48:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:48:12 INFO - 'MOZ_NO_REMOTE': '1', 20:48:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:48:12 INFO - 'NO_EM_RESTART': '1', 20:48:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:48:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:48:12 INFO - 'PWD': '/builds/slave/test', 20:48:12 INFO - 'SHELL': '/bin/bash', 20:48:12 INFO - 'SHLVL': '1', 20:48:12 INFO - 'TERM': 'linux', 20:48:12 INFO - 'TMOUT': '86400', 20:48:12 INFO - 'USER': 'cltbld', 20:48:12 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1493089496.422526-2033550201', 20:48:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:48:12 INFO - '_': '/tools/buildbot/bin/python'} 20:48:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:48:12 INFO - Downloading/unpacking psutil>=3.1.1 20:48:12 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 20:48:12 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 20:48:12 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 20:48:12 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 20:48:12 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 20:48:12 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 20:48:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:48:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:48:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:48:14 INFO - Installing collected packages: psutil 20:48:14 INFO - Running setup.py install for psutil 20:48:14 INFO - building 'psutil._psutil_linux' extension 20:48:14 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 20:48:15 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 20:48:15 INFO - building 'psutil._psutil_posix' extension 20:48:15 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 20:48:15 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 20:48:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:48:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:48:15 INFO - Successfully installed psutil 20:48:15 INFO - Cleaning up... 20:48:15 INFO - Return code: 0 20:48:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:48:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:48:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:48:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:48:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:48:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:48:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:48:15 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 0x21c81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2465b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2463290>, '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 0x2463b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2464040>, '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': '923d835db2ba3686ebe126b700000192-1493089496.422526-2033550201', '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 20:48:15 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 20:48:15 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 20:48:15 INFO - Using env: {'DISPLAY': ':0', 20:48:15 INFO - 'HOME': '/home/cltbld', 20:48:15 INFO - 'LANG': 'en_US.UTF-8', 20:48:15 INFO - 'LANGUAGE': 'en_US:en', 20:48:15 INFO - 'LOGNAME': 'cltbld', 20:48:15 INFO - 'MAIL': '/var/mail/cltbld', 20:48:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:48:15 INFO - 'MOZ_NO_REMOTE': '1', 20:48:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:48:15 INFO - 'NO_EM_RESTART': '1', 20:48:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:48:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:48:15 INFO - 'PWD': '/builds/slave/test', 20:48:15 INFO - 'SHELL': '/bin/bash', 20:48:15 INFO - 'SHLVL': '1', 20:48:15 INFO - 'TERM': 'linux', 20:48:15 INFO - 'TMOUT': '86400', 20:48:15 INFO - 'USER': 'cltbld', 20:48:15 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1493089496.422526-2033550201', 20:48:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:48:15 INFO - '_': '/tools/buildbot/bin/python'} 20:48:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:48:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:48:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:48:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:48:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:48:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:48:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:48:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:48:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:48:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:48:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:48:17 INFO - Installing collected packages: mozsystemmonitor 20:48:17 INFO - Running setup.py install for mozsystemmonitor 20:48:17 INFO - Successfully installed mozsystemmonitor 20:48:17 INFO - Cleaning up... 20:48:17 INFO - Return code: 0 20:48:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:48: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')]} 20:48:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:48:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:48: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')]} 20:48:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:48:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:48: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', '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 0x21c81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2465b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2463290>, '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 0x2463b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2464040>, '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': '923d835db2ba3686ebe126b700000192-1493089496.422526-2033550201', '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 20:48: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:48: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 jsonschema==2.5.1 20:48:17 INFO - Using env: {'DISPLAY': ':0', 20:48:17 INFO - 'HOME': '/home/cltbld', 20:48:17 INFO - 'LANG': 'en_US.UTF-8', 20:48:17 INFO - 'LANGUAGE': 'en_US:en', 20:48:17 INFO - 'LOGNAME': 'cltbld', 20:48:17 INFO - 'MAIL': '/var/mail/cltbld', 20:48:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:48:17 INFO - 'MOZ_NO_REMOTE': '1', 20:48:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:48:17 INFO - 'NO_EM_RESTART': '1', 20:48:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:48:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:48:17 INFO - 'PWD': '/builds/slave/test', 20:48:17 INFO - 'SHELL': '/bin/bash', 20:48:17 INFO - 'SHLVL': '1', 20:48:17 INFO - 'TERM': 'linux', 20:48:17 INFO - 'TMOUT': '86400', 20:48:17 INFO - 'USER': 'cltbld', 20:48:17 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1493089496.422526-2033550201', 20:48:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:48:17 INFO - '_': '/tools/buildbot/bin/python'} 20:48:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:48:18 INFO - Downloading/unpacking jsonschema==2.5.1 20:48: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 20:48: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 20:48: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 20:48: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 20:48: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 20:48: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 20:48:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:48:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:48:20 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 20:48:20 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 20:48:20 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 20:48:20 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 20:48:20 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 20:48:20 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 20:48:20 INFO - Downloading functools32-3.2.3-2.tar.gz 20:48:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:48:20 INFO - warning: no files found matching '*.txt' 20:48:20 INFO - no previously-included directories found matching 'build' 20:48:20 INFO - no previously-included directories found matching 'dist' 20:48:20 INFO - no previously-included directories found matching '.git*' 20:48:20 INFO - Installing collected packages: jsonschema, functools32 20:48:20 INFO - Running setup.py install for functools32 20:48:20 INFO - warning: no files found matching '*.txt' 20:48:20 INFO - no previously-included directories found matching 'build' 20:48:20 INFO - no previously-included directories found matching 'dist' 20:48:20 INFO - no previously-included directories found matching '.git*' 20:48:20 INFO - Successfully installed jsonschema functools32 20:48:20 INFO - Cleaning up... 20:48:20 INFO - Return code: 0 20:48:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:48:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:48:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:48:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:48:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:48:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:48:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:48:20 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 0x21c81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2465b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2463290>, '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 0x2463b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2464040>, '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': '923d835db2ba3686ebe126b700000192-1493089496.422526-2033550201', '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 20:48:20 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 20:48:20 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 20:48:20 INFO - Using env: {'DISPLAY': ':0', 20:48:20 INFO - 'HOME': '/home/cltbld', 20:48:20 INFO - 'LANG': 'en_US.UTF-8', 20:48:20 INFO - 'LANGUAGE': 'en_US:en', 20:48:20 INFO - 'LOGNAME': 'cltbld', 20:48:20 INFO - 'MAIL': '/var/mail/cltbld', 20:48:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:48:20 INFO - 'MOZ_NO_REMOTE': '1', 20:48:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:48:20 INFO - 'NO_EM_RESTART': '1', 20:48:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:48:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:48:20 INFO - 'PWD': '/builds/slave/test', 20:48:20 INFO - 'SHELL': '/bin/bash', 20:48:20 INFO - 'SHLVL': '1', 20:48:20 INFO - 'TERM': 'linux', 20:48:20 INFO - 'TMOUT': '86400', 20:48:20 INFO - 'USER': 'cltbld', 20:48:20 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1493089496.422526-2033550201', 20:48:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:48:20 INFO - '_': '/tools/buildbot/bin/python'} 20:48:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:48:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:48:20 INFO - Cleaning up... 20:48:20 INFO - Return code: 0 20:48:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:48:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:48:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:48:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:48:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:48:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:48:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:48:20 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 0x21c81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2465b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2463290>, '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 0x2463b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2464040>, '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': '923d835db2ba3686ebe126b700000192-1493089496.422526-2033550201', '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 20:48:20 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 20:48:20 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 20:48:20 INFO - Using env: {'DISPLAY': ':0', 20:48:20 INFO - 'HOME': '/home/cltbld', 20:48:20 INFO - 'LANG': 'en_US.UTF-8', 20:48:20 INFO - 'LANGUAGE': 'en_US:en', 20:48:20 INFO - 'LOGNAME': 'cltbld', 20:48:20 INFO - 'MAIL': '/var/mail/cltbld', 20:48:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:48:20 INFO - 'MOZ_NO_REMOTE': '1', 20:48:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:48:20 INFO - 'NO_EM_RESTART': '1', 20:48:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:48:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:48:20 INFO - 'PWD': '/builds/slave/test', 20:48:20 INFO - 'SHELL': '/bin/bash', 20:48:20 INFO - 'SHLVL': '1', 20:48:20 INFO - 'TERM': 'linux', 20:48:20 INFO - 'TMOUT': '86400', 20:48:20 INFO - 'USER': 'cltbld', 20:48:20 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1493089496.422526-2033550201', 20:48:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:48:20 INFO - '_': '/tools/buildbot/bin/python'} 20:48:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:48:21 INFO - Downloading/unpacking blobuploader==1.2.4 20:48: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 20:48: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 20:48: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 20:48: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 20:48: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 20:48: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 20:48:23 INFO - Downloading blobuploader-1.2.4.tar.gz 20:48:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:48:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:48: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 20:48: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 20:48: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 20:48: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 20:48: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 20:48: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 20:48:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:48:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:48: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 20:48: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 20:48: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 20:48: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 20:48: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 20:48: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 20:48:23 INFO - Downloading docopt-0.6.1.tar.gz 20:48:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:48:23 INFO - Installing collected packages: blobuploader, requests, docopt 20:48:23 INFO - Running setup.py install for blobuploader 20:48:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:48:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:48:24 INFO - Running setup.py install for requests 20:48:24 INFO - Running setup.py install for docopt 20:48:24 INFO - Successfully installed blobuploader requests docopt 20:48:24 INFO - Cleaning up... 20:48:24 INFO - Return code: 0 20:48:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:48:24 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')]} 20:48:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:48:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:48:24 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')]} 20:48:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:48:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:48:24 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 0x21c81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2465b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2463290>, '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 0x2463b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2464040>, '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': '923d835db2ba3686ebe126b700000192-1493089496.422526-2033550201', '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 20:48:24 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 20:48:24 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 20:48:24 INFO - Using env: {'DISPLAY': ':0', 20:48:24 INFO - 'HOME': '/home/cltbld', 20:48:24 INFO - 'LANG': 'en_US.UTF-8', 20:48:24 INFO - 'LANGUAGE': 'en_US:en', 20:48:24 INFO - 'LOGNAME': 'cltbld', 20:48:24 INFO - 'MAIL': '/var/mail/cltbld', 20:48:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:48:24 INFO - 'MOZ_NO_REMOTE': '1', 20:48:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:48:24 INFO - 'NO_EM_RESTART': '1', 20:48:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:48:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:48:24 INFO - 'PWD': '/builds/slave/test', 20:48:24 INFO - 'SHELL': '/bin/bash', 20:48:24 INFO - 'SHLVL': '1', 20:48:24 INFO - 'TERM': 'linux', 20:48:24 INFO - 'TMOUT': '86400', 20:48:24 INFO - 'USER': 'cltbld', 20:48:24 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1493089496.422526-2033550201', 20:48:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:48:24 INFO - '_': '/tools/buildbot/bin/python'} 20:48:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:48:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:48:24 INFO - Running setup.py (path:/tmp/pip-cpJFLv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:48:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:48:24 INFO - Running setup.py (path:/tmp/pip-9rYwEn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:48:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:48:24 INFO - Running setup.py (path:/tmp/pip-ILr4Ii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:48:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:48:25 INFO - Running setup.py (path:/tmp/pip-qaKyip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:48:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:48:25 INFO - Running setup.py (path:/tmp/pip-Gl5rKZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:48:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:48:25 INFO - Running setup.py (path:/tmp/pip-MEu1aR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:48:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:48:25 INFO - Running setup.py (path:/tmp/pip-QQx5K1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:48:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:48:25 INFO - Running setup.py (path:/tmp/pip-0dWAG8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:48:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:48:25 INFO - Running setup.py (path:/tmp/pip-OexsGU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:48:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:48:25 INFO - Running setup.py (path:/tmp/pip-cylMoP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:48:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:48:25 INFO - Running setup.py (path:/tmp/pip-iGP7sM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:48:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:48:25 INFO - Running setup.py (path:/tmp/pip-UMQfXA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:48:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:48:25 INFO - Running setup.py (path:/tmp/pip-wfwBhj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:48:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:48:25 INFO - Running setup.py (path:/tmp/pip-Nqz1t_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:48:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:48:25 INFO - Running setup.py (path:/tmp/pip-YILaPl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:48:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:48:25 INFO - Running setup.py (path:/tmp/pip-fY8JrX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:48:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:48:25 INFO - Running setup.py (path:/tmp/pip-Y9IaP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:48:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:48:26 INFO - Running setup.py install for manifestparser 20:48:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:48:26 INFO - Running setup.py install for mozcrash 20:48:26 INFO - Running setup.py install for mozdebug 20:48:26 INFO - Running setup.py install for mozdevice 20:48:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:48:26 INFO - Running setup.py install for mozfile 20:48:26 INFO - Running setup.py install for mozhttpd 20:48:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:48:26 INFO - Running setup.py install for mozinfo 20:48:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:48:26 INFO - Running setup.py install for mozInstall 20:48:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:48:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:48:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:48:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:48:26 INFO - Running setup.py install for mozleak 20:48:26 INFO - Running setup.py install for mozlog 20:48:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:48:27 INFO - Running setup.py install for moznetwork 20:48:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:48:27 INFO - Running setup.py install for mozprocess 20:48:27 INFO - Running setup.py install for mozprofile 20:48:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:48:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:48:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:48:27 INFO - Running setup.py install for mozrunner 20:48:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:48:27 INFO - Running setup.py install for mozscreenshot 20:48:27 INFO - Running setup.py install for moztest 20:48:27 INFO - Running setup.py install for mozversion 20:48:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:48:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:48:27 INFO - Cleaning up... 20:48:27 INFO - Return code: 0 20:48:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:48:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:48:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:48:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:48:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:48:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:48:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:48:27 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 0x21c81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2465b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2463290>, '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 0x2463b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2464040>, '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': '923d835db2ba3686ebe126b700000192-1493089496.422526-2033550201', '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 20:48:27 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 20:48:27 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 20:48:27 INFO - Using env: {'DISPLAY': ':0', 20:48:27 INFO - 'HOME': '/home/cltbld', 20:48:27 INFO - 'LANG': 'en_US.UTF-8', 20:48:27 INFO - 'LANGUAGE': 'en_US:en', 20:48:27 INFO - 'LOGNAME': 'cltbld', 20:48:27 INFO - 'MAIL': '/var/mail/cltbld', 20:48:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:48:27 INFO - 'MOZ_NO_REMOTE': '1', 20:48:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:48:27 INFO - 'NO_EM_RESTART': '1', 20:48:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:48:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:48:27 INFO - 'PWD': '/builds/slave/test', 20:48:27 INFO - 'SHELL': '/bin/bash', 20:48:27 INFO - 'SHLVL': '1', 20:48:27 INFO - 'TERM': 'linux', 20:48:27 INFO - 'TMOUT': '86400', 20:48:27 INFO - 'USER': 'cltbld', 20:48:27 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1493089496.422526-2033550201', 20:48:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:48:27 INFO - '_': '/tools/buildbot/bin/python'} 20:48:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:48:28 INFO - Running setup.py (path:/tmp/pip-JYUGHj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:48:28 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)) 20:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:48:28 INFO - Running setup.py (path:/tmp/pip-zOsiNX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:48:28 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)) 20:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:48:28 INFO - Running setup.py (path:/tmp/pip-OrkzhC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:48:28 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)) 20:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:48:28 INFO - Running setup.py (path:/tmp/pip-Rg7peo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:48:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 20:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:48:28 INFO - Running setup.py (path:/tmp/pip-NmK04z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:48:28 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)) 20:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:48:28 INFO - Running setup.py (path:/tmp/pip-a2eTKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:48:28 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)) 20:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:48:28 INFO - Running setup.py (path:/tmp/pip-ez9ltU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:48:28 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)) 20:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:48:28 INFO - Running setup.py (path:/tmp/pip-cgH26Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:48:28 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)) 20:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:48:28 INFO - Running setup.py (path:/tmp/pip-iLX14C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:48:28 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)) 20:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:48:28 INFO - Running setup.py (path:/tmp/pip-rdL2Xa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:48:28 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)) 20:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:48:28 INFO - Running setup.py (path:/tmp/pip-XKm9BA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:48:28 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)) 20:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:48:28 INFO - Running setup.py (path:/tmp/pip-WCxqyW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:48:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 20:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:48:28 INFO - Running setup.py (path:/tmp/pip-HaCk6L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:48:28 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)) 20:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:48:28 INFO - Running setup.py (path:/tmp/pip-inSbp1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:48:29 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)) 20:48:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:48:29 INFO - Running setup.py (path:/tmp/pip-7KBwnl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:48:29 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)) 20:48:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:48:29 INFO - Running setup.py (path:/tmp/pip-cyKn8i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:48:29 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)) 20:48:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:48:29 INFO - Running setup.py (path:/tmp/pip-ogoxar-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:48:29 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)) 20:48:29 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)) 20:48:29 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)) 20:48:29 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)) 20:48:29 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:48:29 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:48:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:48: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 20:48: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 20:48: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 20:48: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 20:48: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 20:48: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 20:48:31 INFO - Downloading blessings-1.6.tar.gz 20:48:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:48:31 INFO - Installing collected packages: blessings 20:48:31 INFO - Running setup.py install for blessings 20:48:31 INFO - Successfully installed blessings 20:48:31 INFO - Cleaning up... 20:48:31 INFO - Return code: 0 20:48:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:48:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:48:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:48:31 INFO - Reading from file tmpfile_stdout 20:48:31 INFO - Current package versions: 20:48:31 INFO - argparse == 1.2.1 20:48:31 INFO - blessings == 1.6 20:48:31 INFO - blobuploader == 1.2.4 20:48:31 INFO - docopt == 0.6.1 20:48:31 INFO - functools32 == 3.2.3-2 20:48:31 INFO - jsonschema == 2.5.1 20:48:31 INFO - manifestparser == 1.1 20:48:31 INFO - mozInstall == 1.12 20:48:31 INFO - mozcrash == 1.0 20:48:31 INFO - mozdebug == 0.1 20:48:31 INFO - mozdevice == 0.50 20:48:31 INFO - mozfile == 1.2 20:48:31 INFO - mozhttpd == 0.7 20:48:31 INFO - mozinfo == 0.9 20:48:31 INFO - mozleak == 0.1 20:48:31 INFO - mozlog == 3.4 20:48:31 INFO - moznetwork == 0.27 20:48:31 INFO - mozprocess == 0.25 20:48:31 INFO - mozprofile == 0.28 20:48:31 INFO - mozrunner == 6.13 20:48:31 INFO - mozscreenshot == 0.1 20:48:31 INFO - mozsystemmonitor == 0.3 20:48:31 INFO - moztest == 0.8 20:48:31 INFO - mozversion == 1.4 20:48:31 INFO - psutil == 3.1.1 20:48:31 INFO - requests == 1.2.3 20:48:31 INFO - wsgiref == 0.1.2 20:48:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:48:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:48:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:48:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:48:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:48:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:48:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:48:31 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 0x21c81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2465b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2463290>, '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 0x2463b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2464040>, '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': '923d835db2ba3686ebe126b700000192-1493089496.422526-2033550201', '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 20:48:31 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 20:48:31 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 20:48:31 INFO - Using env: {'DISPLAY': ':0', 20:48:31 INFO - 'HOME': '/home/cltbld', 20:48:31 INFO - 'LANG': 'en_US.UTF-8', 20:48:31 INFO - 'LANGUAGE': 'en_US:en', 20:48:31 INFO - 'LOGNAME': 'cltbld', 20:48:31 INFO - 'MAIL': '/var/mail/cltbld', 20:48:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:48:31 INFO - 'MOZ_NO_REMOTE': '1', 20:48:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:48:31 INFO - 'NO_EM_RESTART': '1', 20:48:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:48:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:48:31 INFO - 'PWD': '/builds/slave/test', 20:48:31 INFO - 'SHELL': '/bin/bash', 20:48:31 INFO - 'SHLVL': '1', 20:48:31 INFO - 'TERM': 'linux', 20:48:31 INFO - 'TMOUT': '86400', 20:48:31 INFO - 'USER': 'cltbld', 20:48:31 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1493089496.422526-2033550201', 20:48:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:48:31 INFO - '_': '/tools/buildbot/bin/python'} 20:48:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:48:32 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)) 20:48:32 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)) 20:48:32 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)) 20:48:32 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)) 20:48:32 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)) 20:48:32 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)) 20:48:32 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)) 20:48:32 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)) 20:48:32 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)) 20:48:32 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)) 20:48:32 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)) 20:48:32 INFO - Cleaning up... 20:48:32 INFO - Return code: 0 20:48:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:48:32 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')]} 20:48:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:48:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:48:32 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')]} 20:48:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:48:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:48:32 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 0x21c81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2465b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2463290>, '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 0x2463b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2464040>, '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': '923d835db2ba3686ebe126b700000192-1493089496.422526-2033550201', '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 20:48:32 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 20:48:32 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 20:48:32 INFO - Using env: {'DISPLAY': ':0', 20:48:32 INFO - 'HOME': '/home/cltbld', 20:48:32 INFO - 'LANG': 'en_US.UTF-8', 20:48:32 INFO - 'LANGUAGE': 'en_US:en', 20:48:32 INFO - 'LOGNAME': 'cltbld', 20:48:32 INFO - 'MAIL': '/var/mail/cltbld', 20:48:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:48:32 INFO - 'MOZ_NO_REMOTE': '1', 20:48:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:48:32 INFO - 'NO_EM_RESTART': '1', 20:48:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:48:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:48:32 INFO - 'PWD': '/builds/slave/test', 20:48:32 INFO - 'SHELL': '/bin/bash', 20:48:32 INFO - 'SHLVL': '1', 20:48:32 INFO - 'TERM': 'linux', 20:48:32 INFO - 'TMOUT': '86400', 20:48:32 INFO - 'USER': 'cltbld', 20:48:32 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1493089496.422526-2033550201', 20:48:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:48:32 INFO - '_': '/tools/buildbot/bin/python'} 20:48:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:48:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:48:32 INFO - Cleaning up... 20:48:32 INFO - Return code: 0 20:48:32 INFO - Running post-action listener: _resource_record_post_action 20:48:32 INFO - Running post-action listener: _start_resource_monitoring 20:48:32 INFO - Starting resource monitoring. 20:48:32 INFO - [mozharness: 2017-04-25 03:48:32.294039Z] Finished create-virtualenv step (success) 20:48:32 INFO - [mozharness: 2017-04-25 03:48:32.294589Z] Running install step. 20:48:32 INFO - Running pre-action listener: _resource_record_pre_action 20:48:32 INFO - Running main action method: install 20:48:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:48:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:48:32 INFO - Reading from file tmpfile_stdout 20:48:32 INFO - Detecting whether we're running mozinstall >=1.0... 20:48:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:48:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:48:32 INFO - Reading from file tmpfile_stdout 20:48:32 INFO - Output received: 20:48:32 INFO - Usage: mozinstall [options] installer 20:48:32 INFO - Options: 20:48:32 INFO - -h, --help show this help message and exit 20:48:32 INFO - -d DEST, --destination=DEST 20:48:32 INFO - Directory to install application into. [default: 20:48:32 INFO - "/builds/slave/test"] 20:48:32 INFO - --app=APP Application being installed. [default: firefox] 20:48:32 INFO - mkdir: /builds/slave/test/build/application 20:48:32 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'] 20:48:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 20:48:47 INFO - Reading from file tmpfile_stdout 20:48:47 INFO - Output received: 20:48:47 INFO - /builds/slave/test/build/application/firefox/firefox 20:48:47 INFO - Running post-action listener: _resource_record_post_action 20:48:47 INFO - [mozharness: 2017-04-25 03:48:47.453536Z] Finished install step (success) 20:48:47 INFO - [mozharness: 2017-04-25 03:48:47.453806Z] Running run-tests step. 20:48:47 INFO - Running pre-action listener: _resource_record_pre_action 20:48:47 INFO - Running main action method: run_tests 20:48:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:48:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:48:47 INFO - Python 2.7.3 20:48:47 INFO - Return code: 0 20:48:47 INFO - grabbing minidump binary from tooltool 20:48:47 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')]} 20:48:47 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 0x2463290>, '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 0x2463b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2464040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:48:47 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 20:48:47 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 20:48:47 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 20:48:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:48:47 INFO - Return code: 0 20:48:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:48:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:48:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:48:47 INFO - ENV: RUST_BACKTRACE is now 1 20:48:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:48:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:48:47 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JqbWFgNnSc2wFIq8kjQJ2w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 20:48:47 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JqbWFgNnSc2wFIq8kjQJ2w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-007 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 20:48:47 INFO - Using env: {'DISPLAY': ':0', 20:48:47 INFO - 'HOME': '/home/cltbld', 20:48:47 INFO - 'LANG': 'en_US.UTF-8', 20:48:47 INFO - 'LANGUAGE': 'en_US:en', 20:48:47 INFO - 'LOGNAME': 'cltbld', 20:48:47 INFO - 'MAIL': '/var/mail/cltbld', 20:48:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:48:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:48:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:48:47 INFO - 'MOZ_NO_REMOTE': '1', 20:48:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:48:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:48:47 INFO - 'NO_EM_RESTART': '1', 20:48:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:48:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:48:47 INFO - 'PWD': '/builds/slave/test', 20:48:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:48:47 INFO - 'RUST_BACKTRACE': '1', 20:48:47 INFO - 'SHELL': '/bin/bash', 20:48:47 INFO - 'SHLVL': '1', 20:48:47 INFO - 'TERM': 'linux', 20:48:47 INFO - 'TMOUT': '86400', 20:48:47 INFO - 'USER': 'cltbld', 20:48:47 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1493089496.422526-2033550201', 20:48:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:48:47 INFO - '_': '/tools/buildbot/bin/python'} 20:48:47 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JqbWFgNnSc2wFIq8kjQJ2w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 20:48:47 INFO - mozversion application_buildid: 20170425032234 20:48:47 INFO - mozversion application_changeset: f0621f7f0520476b10eda7b4a59cb976b1e1f2b9 20:48:47 INFO - mozversion application_display_name: Nightly 20:48:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:48:47 INFO - mozversion application_name: Firefox 20:48:47 INFO - mozversion application_remotingname: firefox 20:48:47 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 20:48:47 INFO - mozversion application_vendor: Mozilla 20:48:47 INFO - mozversion application_version: 55.0a1 20:48:47 INFO - mozversion platform_buildid: 20170425032234 20:48:47 INFO - mozversion platform_changeset: f0621f7f0520476b10eda7b4a59cb976b1e1f2b9 20:48:47 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 20:48:47 INFO - mozversion platform_version: 55.0a1 20:48:47 INFO - using testdate: 1493092127 20:48:47 INFO - actual date: 1493092127 20:48:47 INFO - starting webserver on 'localhost:53959' 20:48:47 INFO - SUITE-START | Running 2 tests 20:48:47 INFO - TEST-START | dromaeo_css 20:48:47 INFO - operating with platform_type : linux_ 20:48:47 INFO - Initialising browser for dromaeo_css test... 20:48:47 INFO - TEST-INFO | started process 509 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc6H90I/profile http://localhost:53959/getInfo.html) 20:48:51 INFO - PID 509 | __metrics Screen width/height:1600/1200 20:48:51 INFO - PID 509 | colorDepth:24 20:48:51 INFO - PID 509 | Browser inner width/height: 1024/697 20:48:51 INFO - PID 509 | __metrics 20:48:52 INFO - PID 509 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:48:52 INFO - PID 509 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:48:53 INFO - TEST-INFO | 509: exit 0 20:48:53 INFO - Browser initialized. 20:48:53 INFO - Running cycle 1/1 for dromaeo_css test... 20:48:53 INFO - TEST-INFO | started process 607 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc6H90I/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:49:05 INFO - PID 607 | RSS: Main: 156835840 20:49:05 INFO - PID 607 | 20:52:12 INFO - PID 607 | Cycle 1(1): loaded http://localhost:53959/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53959/tests/dromaeo/cssquery-ext.html) 20:52:14 INFO - PID 607 | RSS: Main: 305897472 20:52:14 INFO - PID 607 | 20:53:54 INFO - PID 607 | ************************* 20:53:54 INFO - PID 607 | A coding exception was thrown and uncaught in a Task. 20:53:54 INFO - PID 607 | 20:53:54 ERROR - PID 607 | Full message: TypeError: NetworkError when attempting to fetch resource. 20:53:54 INFO - PID 607 | Full stack: 20:53:54 INFO - PID 607 | ************************* 20:53:54 INFO - PID 607 | ************************* 20:53:54 INFO - PID 607 | A coding exception was thrown and uncaught in a Task. 20:53:54 INFO - PID 607 | 20:53:54 ERROR - PID 607 | Full message: TypeError: NetworkError when attempting to fetch resource. 20:53:54 INFO - PID 607 | Full stack: 20:53:54 INFO - PID 607 | ************************* 20:53:54 INFO - PID 607 | ************************* 20:53:54 INFO - PID 607 | A coding exception was thrown and uncaught in a Task. 20:53:54 INFO - PID 607 | 20:53:54 ERROR - PID 607 | Full message: TypeError: NetworkError when attempting to fetch resource. 20:53:54 INFO - PID 607 | Full stack: 20:53:54 INFO - PID 607 | ************************* 20:53:54 INFO - PID 607 | ************************* 20:53:54 INFO - PID 607 | A coding exception was thrown and uncaught in a Task. 20:53:54 INFO - PID 607 | 20:53:54 ERROR - PID 607 | Full message: TypeError: NetworkError when attempting to fetch resource. 20:53:54 INFO - PID 607 | Full stack: 20:53:54 INFO - PID 607 | ************************* 20:55:16 INFO - PID 607 | Cycle 1(1): loaded http://localhost:53959/tests/dromaeo/cssquery-ext.html (next: http://localhost:53959/tests/dromaeo/cssquery-jquery.html) 20:55:17 INFO - PID 607 | RSS: Main: 242040832 20:55:17 INFO - PID 607 | 20:58:19 INFO - PID 607 | Cycle 1(1): loaded http://localhost:53959/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53959/tests/dromaeo/cssquery-mootools.html) 20:58:19 INFO - PID 607 | RSS: Main: 180994048 20:58:19 INFO - PID 607 | 21:01:21 INFO - PID 607 | Cycle 1(1): loaded http://localhost:53959/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53959/tests/dromaeo/cssquery-prototype.html) 21:01:22 INFO - PID 607 | RSS: Main: 178720768 21:01:22 INFO - PID 607 | 21:04:25 INFO - PID 607 | Cycle 1(1): loaded http://localhost:53959/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53959/tests/dromaeo/cssquery-yui.html) 21:04:26 INFO - PID 607 | RSS: Main: 182808576 21:04:26 INFO - PID 607 | 21:07:28 INFO - PID 607 | Cycle 1(1): loaded http://localhost:53959/tests/dromaeo/cssquery-yui.html (next: http://localhost:53959/tests/dromaeo/cssquery-dojo.html) 21:07:28 INFO - PID 607 | RSS: Main: 271339520 21:07:28 INFO - PID 607 | 21:07:28 INFO - PID 607 | __start_tp_report 21:07:28 INFO - PID 607 | _x_x_mozilla_page_load 21:07:28 INFO - PID 607 | _x_x_mozilla_page_load_details 21:07:28 INFO - PID 607 | |i|pagename|runs| 21:07:28 INFO - PID 607 | |0;dojo.html;2701.635279237303;2701.94596108078;2707.945841083177;2732.8633568321584;2747.162115554755;4858.781354839032;5022.347094877661;5049.015441988814;5093.3124028256225;5142.845714628563;4999.25011248313;5001.424836143845;5068.4424713281505;5112.335396398463;5156.716380599066;4500.234960056782;4513.774311284439;4516.983678672305;4609.262517997121;4627.051454451829;4593.966357569553;4619.237825758746;4627.282771170457;4668.789904454291;4703.365045718819;4419.359192917042;4481.8655440336515;4489.955100448987;4541.636669066466;4613.1696294666945;4565.771711414416;4567.817287308504;4581.702189357681;4630.536946305376;4632.930506042412;4537.1833070047705;4542.6138778203895;4562.498125206258;4593.150267200579;4618.861434156981;4894.583960363373;4958.206686930074;5089.389273287192;5100.38795344561;5101.2093125565225;5352.652077614982;5353.116735738598;5353.9196912046355;5355.571554275649;5358.196270559409;5367.651102678353;5368.141097424394;5369.140937449989;5372.758225879845;5373.35519737634;4954.851354459372;5007.073691367109;5007.824726134604;5010.448850626428;5019.3976722793495;5439.5104440600535;5488.53347465462;5492.286002819608;5495.670259784426;5496.972515137399;5258.894822103536;5370.355557333145;5435.157550579666;5443.455654434525;5445.809396671098;5494.972525137348;5511.614187006951;5515.558755299567;5517.2551705520045;5528.889422211533;5460.290162278958;5471.972640136853;5482.259894914216;5487.5609951203805;5514.889702205934;5279.340082489689;5357.517823395913;5365.785368585291;5421.26812880264;5481.451854814487;4501.864944051684;4504.549545045535;4517.457905051349;4544.2274813281165;4547.1815073287125;3899.941500877489;3917.7845218513257;3928.724989250782;3931.1154990126993;3959;4497.190505708938;4583.19794036049;4584.472785629629;4683.344331793552;4719.244920812722;5393.6763794172475;5400.702961337086;5404.8108316208745;5408.269883565668;5409.377921538995;4590.242609969385;4596.10375976688;4598.563136502027;4598.839040633562;4602.585767280961;4765.571098601143;4767.332573439721;4772.236442169236;4773.904521909542;4776.068666609977;5001.974990125026;5062.291279220985;5097.8725531861255;5102.158143906214;5112.923306150336;5402.837914862561;5405.054115529845;5406.972965135149;5408.513233808976;5408.78364865401;5103.821366252163;5114.9232761507865;5152.922706159336;5163.4578369270685;5204.0892843752945;5442.537384322219;5447.237386765777;5454.618176727591;5456.48163424474;5460.590455715757;5300.9734951325;5517.668939863621;5529.4470552944385;5531.170324451365;5588.720563971867;5218;5219.1388420910125;5286.788528458818;5299.8410047698635;5359.222912677562;5326.520613144836;5327.493888080626;5333.4133245343755;5333.599980001438;5368.812091576776;5254.737263136904;5254.816081437284;5258.2375555544995;5266.710330931835;5311.176767601028;5185.066687996046;5255.3693556771905;5259.815906443256;5278.155495120763;5358.946410536;5210.635255532076;5231.398389185292;5233.685978841282;5265.815696450606;5283.049051170826 21:07:28 INFO - PID 607 | |1;ext.html;602.4878852974972;678.4640134293908;694.3611877073092;1040.0171837613454;1059.6556119261243;27134;27758.722412775867;27777.166684999433;27785.861070694642;27810.165695029133;29993.700062999364;30613.846930765372;30730.23174420635;30800.383992320196;31050.689493105063;7091.645417729132;7197.928020719804;7206.891896621555;7213.747518836842;7221.747238846641;5618.887622247553;7146.892796608029;7247.130344358658;7251.7461888833905;7265.818354541126;5798.246227990377;7203.423726101899;7391.926080739205;7399.556026638392;7400.666969986363;7384.963075184616;7408.888866667005;7435.516691415095;7438.404927605833;7443.06961629799;7302.415806735448;7383.630818459109;7384.261573842627;7393.482456228066;7393.482456228066;24312.513749724905;25178;31029.379412411625;31858.04425867228;31925.52111718326;3034.4386288536693;3064.8007879487764;3071.5699802027734;3073.4621441247914;3073.554334621467;25193.87403062991;25230.495390092277;25235.747642523707;25256.747432525808;25263.242102736946;3201.9039428817173;3210.855511501988;3211.983940080308;3230.095573239497;3230.2570408806105;141693;141814;141885.2905735475;142006;142165;42331.15337693229;42370.364444533356;42444.363334550006;42476;42521.36217956733;44342.77828610836;44355.33466997997;44434.445244380375;44450.33324500135;44460.3330950036;10128.139108175741;10230.07929286353;10235.078842904175;10239;10240.539175737109;7938.126806051329;7948.880766788503;7948.960255198803;7950.363970882316;7953.12515623281;10368.118709909591;11950.34273114987;12165.939170304091;12229.816552751716;12328.32194229308;4414.24109931293;4418.756968366706;4458.665600080007;4524.23088075028;4836.46798852126;909.072745799281;910.6038873090226;915.555955361649;918.9678361257323;924.7780532672244;21108.47228819261;21670.674939875913;21698.783012169675;21701.565968680537;21837.235696750537;955.7801705607749;965.1410244882061;965.1506674126723;974.5273542331963;992.4144754594823;11488.368139752394;11496.712582185512;11500.079993600491;11518.136139789382;11653.126015548867;158635;158803;158917;158937.205313975;159041;41060.178796423905;41323.1735365291;41326.173476530304;41367;41452.79273603673;1187.3779302791093;1213.6116442738416;1220.4020030185322;1225.2158618484177;1225.4424236972156;19512;19718.704219436433;20330.491737706674;21056.789432105485;21336.359909202747;29836;29997.850010749808;29999.250018749706;30016;30029;155236.2238188802;155259;155299;155831;155868;28763.568546472237;28838.279043024093;29221;30127.397452051275;30177.698223017487;37639.059023524635;37690.43464348092;37737.62262377451;37818.81090594529;37883.431748523246;25856;27275.86362068177;28584.142475725763;29384.26539336534;29860.850695746383;28263.717362826108;28291.43417131687;28350.858245708638;29422.411551769274;29862.25344366408;31530.36939261248;32055.839720801247;32108.19729506781;32179.51730724088;32246.83876580602;27926.72073279241;28408.57387139236;28440.57339139956;28712.425751485272;29507.85246073756;20823;22734.20430284932;22762.317130486113;22920.426989324733;22954.42613934665 21:07:28 INFO - PID 607 | |2;jquery.html;405.57617289932017;409.3573090248308;417.5615603616203;434.5806296923468;434.9064951035527;16435.917820410898;16454.21553042801;16851.07319097449;17128.571785705364;17172.14139293035;15333.386664533406;15450.5364839055;15490.225488725548;15550.533483995498;15660.295286712097;5529.612927095105;5540.806071787489;5751.741171647265;5765.509931655814;5781.219535362735;5551.77792888284;5673.177389278552;5696.344920334152;5696.490430036044;5700.7719691212305;5619.241402410684;5647.971760141214;5656.802011929583;5661.943380566204;5667.0932650775885;5510.559155267589;5646.6894320812335;5656.321241451032;5657.632253903504;5682.943170568324;5070.112730272188;5076.898462030738;5108.310378098946;5115.028144652541;5115.795368185268;20421.183152673875;20445.897770511052;20629.277975270943;20775.8961205193;20798;1684.6967545841744;1716.416418417744;1719.389616686071;1726.47342560519;1726.896386216831;13768.955665221518;13791.51729689466;13928.025038247326;13993.3702983366;14002.719945601133;1904.6952487601918;1916.4059141666128;1966.9378535590906;1968.9507762305914;1976.3379267945256;66190;76423.61788191079;90895.54552227263;91715.54142229313;91939.54030229873;10527.84208236877;10568.947155264328;10571.62999295021;10765.784684306427;10784.191185661106;15021;15044.774328385083;15051.322690478735;15061.623459413384;15073.170975596448;6646.169228846395;6655.5341126121675;6806.217285012287;6838.897416538756;6894.551854129466;5870.090136028923;5959.28488581373;6083.8479038023515;6107.664078475637;6141.140240366352;6751.291114433012;6765.023389708513;6786.8303292417095;6857.382835544725;6888.726720182328;1952.4630726550029;1971.8323942464765;1985.5631761012555;1994.4016794961453;2025.3721346382667;887.4896934262824;913.0595486648763;914.1635403605759;915.2677857713802;937.2314701944476;16729.54221952377;17153;17765.111744412727;17819.643607127786;18032.90983545074;901.3420203251663;901.5627420700955;902.963881444748;905.3481493324796;918.3204428722697;9242.3530352876;9637.855432168522;9705.6603018894;9738.513074346254;9774.657886973922;366592;373487;376546;378359;382019;78055.60972195216;80438;80934.19065809384;83636;85009.57495212484;1046.246702374274;1068.8289873620183;1092.6066616018227;1098.1653943003375;1100.1254003067581;14507.92746036263;14646.780298295747;14676.266186690837;14785.260736963324;15277.465288714842;38545.807270963465;40383;40786.38820417756;40956.59043409528;41852.37221441742;51664.48335516597;51908.480915191874;52054.73972630112;54081;56144.15783763328;11243.7751244973;11349.659510214708;11410;12324.876751232372;12864.163829351062;13004.739905202032;13132.146410483288;13203.603891883258;13311.80032299497;13414.597562073153;11324.830127547928;11326.32042077478;11507.021903137993;11545.942270288595;11595.5941542049;10245.180385569285;10283.537240824331;10386.636467723594;11049;11209.943950280196;11139.665810025712;11618.128640352177;11749.706257343634;11920.165588408729;12141.817872731739;12182.451789669663;12200.450979705756;12253.632391028283;12746.936265318614;12749.023901295313;10810.945945270223;10873.184511161537;10918;11065.944670276596;11354.602588909349 21:07:28 INFO - PID 607 | |3;mootools.html;1250.9624711258662;1290.1485019886877;1310.7050913544454;1322.9404676789557;1330.201878872676;9481.715548533537;9786.412815231091;9798.608055677772;9801.901980980188;9814.950925245374;9538.856917146231;9599.616015359396;9880;9897.604095836175;9927.801443971117;2193.0898677049004;2242.248846636379;2242.551489702058;2242.990654205606;2243.55128974205;1914.176903931316;1999.5201151723554;2003.4390370696156;2003.9599208015832;2005.8395328373695;1753.32496988659;1816.6729988602046;1823.0155715913456;1826;1826.269492203116;2117.100232401231;2199.4061603367163;2204.1293688992837;2205.106931692667;2209.928184830356;1981.682930731076;1989.9602007959904;1998.3105828489147;2000.6895483458359;2004.4387571480008;8584.656613735444;9758.268129890215;9767.072128147815;9777.755556111082;10076.445795481246;4494.662900282459;5373.2208829719475;5532.474414930575;5537.390887002426;5550.4449555044575;3048.420800047984;3239.9028029159163;3290.3090351026312;3294.96705032949;3306.173456635841;1028.9073983341461;1055.0399136785488;1065.3767545985609;1066.1843689577402;1076.2036093290988;14000.369983350673;14130.858691413057;14193.929030354886;14251.643708907257;14291.213983230919;4500.639948804088;4620.907581848344;4694;4700.435947686231;4710.458297295855;10997.12023038155;10998.725031874266;11012.559497620166;11020.724481887857;11032.50353734084;5167.767450464738;5240.868978275497;5256.92114618281;5262.7631756571045;5264.894702105937;4637;4778.331033655291;4789.568938795525;4850.587700045465;4851.902961940741;3823.5029446172375;3876.3022655922205;3893;3949.0917089069676;3959;1150.2523359816187;1161.5411912294596;1176.3824740981152;1196.9940150299192;1202.8316035755001;713.3294702979183;717.9605121718251;723.5369363607296;731.1518638379455;743.3124359967117;5057.519535644108;5078.3905931287745;5244.5542128918705;5255.474452554714;5348.572114230852;453.31593131516576;543.8531596468931;544.5317027356471;558.6452602597299;560.9719514024282;4053.2298863215897;4196.874093777192;4205.789710514462;4253.510846252659;4348.152110338454;12429.689257768629;12525.373731313397;12735.808962865565;12771;12789.360531973363;12263.75472490563;12579.622611321674;12653.430595623218;12654.81017784734;12779.872201278054;7407.185209626937;7593.392528597588;7602.315791578784;7609.543427394374;7613.543187408663;5714.228579141763;5894.882102358015;6010.398960103955;6036.849078773066;6076.8784624308155;11040.392778397265;11055;11128.666140015812;11197.048250898439;11266.66200014001;11241.213115082193;11314.208005439541;11375.374354410256;11386.373749443861;11393.658190254306;8091.150429205084;8254.83490330202;8306.792330191794;8522.531260780717;8538.292341531842;9013.549322533716;9188.95405522968;9189.402688825205;9193.678221262491;9220.861687074834;7350.96324518374;7605.391568674382;7722.3049925506975;7791.415643826623;7820.257075577811;7232.74685386009;7563;7563.697452102075;7713.961430192813;7931.5637639930355;6996.860062798613;7003.019577259086;7042.577445353295;7162.212156662658;7165.426765858823;4158.604932531404;5143.3570803649545;5158.38099428071;5158.845234642967;5354.196870469305;5245.674054241597;5265.515799534121;5401.108817045144;5412.78348866041;5456.699881506396 21:07:28 INFO - PID 607 | |4;prototype.html;384.6691845013288;385.0623731214493;389.36922186058587;389.53450626501325;389.7564022485946;5116.795328186873;5127.846164615058;5128.410232823227;5151.536361727449;5153.587712982961;4820.879478013051;5047.949520504794;5059.443461219272;5072.746362681861;5086.821961231358;3880.301545721776;3938.2714197873343;3943.0536671198993;3948.9802550987206;3952.940705889414;3929.332013557702;3931.331673615492;3952.505936757905;3957.4063890416523;3965.8017099145072;3905.1799122184375;3906.1211227473877;3912.3740201567753;3912.941305880414;3930.547986981491;3800.771953682774;3882.9223415531533;3887.3391523441082;3909.9218015639526;3935.2129574085297;3411.6417776133644;3464.133966508373;3466;3466.7346418557045;3467.219875528011;4958.677685950402;4977.328060711794;4980.501949805027;4984.750762461898;4989.57588604969;4462.576055274743;4533.455985281755;4566.337881007235;4575.954240457586;4595.517470665565;5352.759125839347;5358.651687640291;5364.892702145935;5377.838664840022;5384.542313903284;3853.402722577977;3866.5553461352024;3869.787161706105;3874.1670540833575;3874.341361968472;5550.972245138749;5634.211210430502;5652.869426114752;5708.543316534668;5719.628224165416;3932.095618007817;3940.0937784309194;3958.0698535844053;3959.762414255154;3960.821763020613;4024.1348110155873;4024.531046168186;4027.9798601006805;4031.5968403160036;4035.1324465240114;4458.464984201852;4578.88552786183;4580.198465268565;4586.954130458719;4591.058832939306;5338.652987555796;5346.91979620306;5385.7576409061685;5401.675899446046;5403.594730395236;1365.1672479787321;1376.1330361871956;1381.5648070857649;1383.861613838608;1386.682651481097;891.4666773150171;929.484136304344;945.5603144537686;946.9100435458621;948.9857652135223;4721.787519561628;4729.95270047302;4730.692504987165;4731.739754313546;4751.572358487752;5569.526590239875;5574.665520068809;5576.2713558796095;5591.524720398812;5594.83891601244;4594;4695.906081878344;4708.9058218835435;4714.619117345718;4716.29255611661;2915.3003279212835;2954.8079374840568;2968.717971792676;2970.301979034925;2986.4475072111295;5229.267902493654;5258.868528286824;5277.4986376294955;5313.362396512366;5329.413764485904;5488.53347465462;5747.712614369265;5751.741171647286;5762.798302059407;5781.88436231273;5076.289319495274;5114.5652619527755;5200;5238.5547228486;5248.448912864094;5553.111502159797;5557.416471270459;5564.221009058654;5564.860878478071;5578.470045345685;5299.364076310867;5421.5933804964;5449.209864569536;5514.172874068921;5539.335279766293;5232.927249913682;5264.236685680478;5269.525742683177;5285.590793937966;5289.444608316071;3921.921471595334;3944.526656801202;3949.763014219156;3961.980190099031;3968.1071758854027;5368.409474957673;5588.804391846266;5594.992901277809;5608.803691870929;5615.185798059177;5395.892082158413;5418.945810541844;5425.376081750649;5439.265699130567;5441.83674489766;5410.648307860134;5417.160340147283;5419.647722897999;5430.864228394164;5444.537214336826;5164.1995490699;5313.840584782462;5338.199270109515;5349.679019258857;5362;5410.404855465974;5427.751617128004;5431.696392865605;5447.428020057995;5455.290812194389;5268.1834315681135;5276.2349459327415;5283.622369933469;5291.629585928948;5306 21:07:28 INFO - PID 607 | |5;yui.html;633.9175907132072;748.5658318175457;772.0542335638839;777.8016605765529;787.732171061839;10490.947545262272;14778.556643300692;15221.08673479592;15252.542423727306;15348.846511534895;15050.021748586334;15197.316120774563;15235.390584376639;15286.388544458236;15294;637.419947847459;655.9081728558006;879.4635272483796;893.7676204186926;897.833900728364;869.6695255802817;886.8270687215995;887.786931136529;896.3143195455482;896.9730908072768;954.627695198873;960.1454705312277;960.4045491795097;960.5917485068853;960.851068084448;949.0888746803078;955.2453561686259;955.3885513271512;955.4649396338073;956.4118067388575;705.6189657584898;710.2790667472519;712.0387476906187;712.2023333866103;712.2058904321696;13525.729485410237;13676.247806370646;13730.93134534331;14211.857881421156;14620;14961.177135257556;15207.163606001666;15378.077315361114;15402.152881591508;15409.383624655;11992.400379980965;12252.571160009356;12278.38608069593;12364.44360003802;12368.319742414164;3013.1261934039103;3033.848307584634;3038.4075105354464;3039.9240018999703;3040.9391812163854;71332;72543.27456725418;73152;73328.63335683341;74318.25681743221;12846.871531284754;12848.614541563767;12999.935000325127;13001.739965200642;13077.084604077623;22770.43073923132;22970.540589188124;23195.53608927846;23386.298411047697;23413.531729365317;6023.518118550505;6078.300995385587;6092.116643086816;6239.906401403982;6320.304766475684;3004.8647810848565;3072.0476652237876;3075.384923015406;3075.646300675406;3081.7534597232166;3486.372452958441;3544.2379888324135;3579.1410061585552;3579.391503444421;3602.513660655778;712.0280816685188;726.1685370251139;728.144430294402;730.2660825870073;730.7917243585553;584.4914924016133;601.3084952304797;604.8487878030493;607.9848003799852;627.2191122053073;8983.101689831095;9768.413895166314;10107.595696172071;10254.128399086012;10452.32059916103;557.5567423898011;560.0814663951123;561.8707697229578;565.6153815405481;570.5635189080357;4878.317035614946;5142;5185.844424667266;5314.229436731653;5377.919331210035;65678.34321656723;66170;67001.6649916757;67113.66443167753;68017.3198268011;42016;57064.42935570674;57359.42640573541;57984.42015579875;58200.70899645475;33821.32357352839;36883.4467482988;50877.23684144741;51863;53413.73293133509;10310.278280520291;10584.629537966135;11156.776864462827;11308.773824523629;11325.546978120783;25845.095421660153;26357.736422635528;26671.33321666974;26679.86660066687;27101.457970840078;30576.541351880183;30900.381992359577;31094.067177984696;31217.843910780302;31424.842875785474;13439.395227214995;13690.726185476036;13701.657458563615;13702.383392747151;13934.442622294995;13814.65463363424;14148.080374776018;14302.427902883768;15303.311350989456;15676.92161539185;13199.934000329937;13660.248686322348;13735;14009.43962241499;14884.330205141012;13368.933155334551;13541.1198272112;13957.651058723613;15085.54743357701;15219.315130819361;14066.718665626426;14268;14342.569722907912;14488.927555362156;14545.200013999332;9778.168855647065;9890.258230632588;10070.899291007288;10293.639722609973;10507.211959102944;11242.156838237;11870.169088163746;12162.695932601755;12321.69195770077;12638.684032899251 21:07:28 INFO - PID 607 | __end_tp_report 21:07:28 INFO - PID 607 | __start_cc_report 21:07:28 INFO - PID 607 | _x_x_mozilla_cycle_collect,1624 21:07:28 INFO - PID 607 | __end_cc_report 21:07:28 INFO - PID 607 | __startTimestamp1493093248424__endTimestamp 21:07:28 INFO - PID 607 | 21:07:28 INFO - PID 607 | ------- Summary: start ------- 21:07:28 INFO - PID 607 | Number of tests: 6 21:07:28 INFO - PID 607 | 21:07:28 INFO - PID 607 | [#0] dojo.html Cycles:165 Average:4984.95 Median:5156.72 stddev:563.69 (10.9%) stddev-sans-first:536.21 21:07:28 INFO - PID 607 | Values: 2701.6 2701.9 2707.9 2732.9 2747.2 4858.8 5022.3 5049.0 5093.3 5142.8 4999.3 5001.4 5068.4 5112.3 5156.7 4500.2 4513.8 4517.0 4609.3 4627.1 4594.0 4619.2 4627.3 4668.8 4703.4 4419.4 4481.9 4490.0 4541.6 4613.2 4565.8 4567.8 4581.7 4630.5 4632.9 4537.2 4542.6 4562.5 4593.2 4618.9 4894.6 4958.2 5089.4 5100.4 5101.2 5352.7 5353.1 5353.9 5355.6 5358.2 5367.7 5368.1 5369.1 5372.8 5373.4 4954.9 5007.1 5007.8 5010.4 5019.4 5439.5 5488.5 5492.3 5495.7 5497.0 5258.9 5370.4 5435.2 5443.5 5445.8 5495.0 5511.6 5515.6 5517.3 5528.9 5460.3 5472.0 5482.3 5487.6 5514.9 5279.3 5357.5 5365.8 5421.3 5481.5 4501.9 4504.5 4517.5 4544.2 4547.2 3899.9 3917.8 3928.7 3931.1 3959.0 4497.2 4583.2 4584.5 4683.3 4719.2 5393.7 5400.7 5404.8 5408.3 5409.4 4590.2 4596.1 4598.6 4598.8 4602.6 4765.6 4767.3 4772.2 4773.9 4776.1 5002.0 5062.3 5097.9 5102.2 5112.9 5402.8 5405.1 5407.0 5408.5 5408.8 5103.8 5114.9 5152.9 5163.5 5204.1 5442.5 5447.2 5454.6 5456.5 5460.6 5301.0 5517.7 5529.4 5531.2 5588.7 5218.0 5219.1 5286.8 5299.8 5359.2 5326.5 5327.5 5333.4 5333.6 5368.8 5254.7 5254.8 5258.2 5266.7 5311.2 5185.1 5255.4 5259.8 5278.2 5358.9 5210.6 5231.4 5233.7 5265.8 5283.0 21:07:28 INFO - PID 607 | 21:07:28 INFO - PID 607 | [#1] ext.html Cycles:180 Average:29672.35 Median:16824.14 stddev:39309.33 (233.6%) stddev-sans-first:39358.99 21:07:28 INFO - PID 607 | Values: 602.5 678.5 694.4 1040.0 1059.7 27134.0 27758.7 27777.2 27785.9 27810.2 29993.7 30613.8 30730.2 30800.4 31050.7 7091.6 7197.9 7206.9 7213.7 7221.7 5618.9 7146.9 7247.1 7251.7 7265.8 5798.2 7203.4 7391.9 7399.6 7400.7 7385.0 7408.9 7435.5 7438.4 7443.1 7302.4 7383.6 7384.3 7393.5 7393.5 24312.5 25178.0 31029.4 31858.0 31925.5 3034.4 3064.8 3071.6 3073.5 3073.6 25193.9 25230.5 25235.7 25256.7 25263.2 3201.9 3210.9 3212.0 3230.1 3230.3 141693.0 141814.0 141885.3 142006.0 142165.0 42331.2 42370.4 42444.4 42476.0 42521.4 44342.8 44355.3 44434.4 44450.3 44460.3 10128.1 10230.1 10235.1 10239.0 10240.5 7938.1 7948.9 7949.0 7950.4 7953.1 10368.1 11950.3 12165.9 12229.8 12328.3 4414.2 4418.8 4458.7 4524.2 4836.5 909.1 910.6 915.6 919.0 924.8 21108.5 21670.7 21698.8 21701.6 21837.2 955.8 965.1 965.2 974.5 992.4 11488.4 11496.7 11500.1 11518.1 11653.1 158635.0 158803.0 158917.0 158937.2 159041.0 41060.2 41323.2 41326.2 41367.0 41452.8 1187.4 1213.6 1220.4 1225.2 1225.4 19512.0 19718.7 20330.5 21056.8 21336.4 29836.0 29997.9 29999.3 30016.0 30029.0 155236.2 155259.0 155299.0 155831.0 155868.0 28763.6 28838.3 29221.0 30127.4 30177.7 37639.1 37690.4 37737.6 37818.8 37883.4 25856.0 27275.9 28584.1 29384.3 29860.9 28263.7 28291.4 28350.9 29422.4 29862.3 31530.4 32055.8 32108.2 32179.5 32246.8 27926.7 28408.6 28440.6 28712.4 29507.9 20823.0 22734.2 22762.3 22920.4 22954.4 21:07:28 INFO - PID 607 | 21:07:28 INFO - PID 607 | [#2] jquery.html Cycles:180 Average:25197.75 Median:20433.54 stddev:62461.38 (305.7%) stddev-sans-first:62608.86 21:07:28 INFO - PID 607 | Values: 405.6 409.4 417.6 434.6 434.9 16435.9 16454.2 16851.1 17128.6 17172.1 15333.4 15450.5 15490.2 15550.5 15660.3 5529.6 5540.8 5751.7 5765.5 5781.2 5551.8 5673.2 5696.3 5696.5 5700.8 5619.2 5648.0 5656.8 5661.9 5667.1 5510.6 5646.7 5656.3 5657.6 5682.9 5070.1 5076.9 5108.3 5115.0 5115.8 20421.2 20445.9 20629.3 20775.9 20798.0 1684.7 1716.4 1719.4 1726.5 1726.9 13769.0 13791.5 13928.0 13993.4 14002.7 1904.7 1916.4 1966.9 1969.0 1976.3 66190.0 76423.6 90895.5 91715.5 91939.5 10527.8 10568.9 10571.6 10765.8 10784.2 15021.0 15044.8 15051.3 15061.6 15073.2 6646.2 6655.5 6806.2 6838.9 6894.6 5870.1 5959.3 6083.8 6107.7 6141.1 6751.3 6765.0 6786.8 6857.4 6888.7 1952.5 1971.8 1985.6 1994.4 2025.4 887.5 913.1 914.2 915.3 937.2 16729.5 17153.0 17765.1 17819.6 18032.9 901.3 901.6 903.0 905.3 918.3 9242.4 9637.9 9705.7 9738.5 9774.7 366592.0 373487.0 376546.0 378359.0 382019.0 78055.6 80438.0 80934.2 83636.0 85009.6 1046.2 1068.8 1092.6 1098.2 1100.1 14507.9 14646.8 14676.3 14785.3 15277.5 38545.8 40383.0 40786.4 40956.6 41852.4 51664.5 51908.5 52054.7 54081.0 56144.2 11243.8 11349.7 11410.0 12324.9 12864.2 13004.7 13132.1 13203.6 13311.8 13414.6 11324.8 11326.3 11507.0 11545.9 11595.6 10245.2 10283.5 10386.6 11049.0 11209.9 11139.7 11618.1 11749.7 11920.2 12141.8 12182.5 12200.5 12253.6 12746.9 12749.0 10810.9 10873.2 10918.0 11065.9 11354.6 21:07:28 INFO - PID 607 | 21:07:28 INFO - PID 607 | [#3] mootools.html Cycles:180 Average:6033.68 Median:4628.95 stddev:3842.10 (83.0%) stddev-sans-first:3836.07 21:07:28 INFO - PID 607 | Values: 1251.0 1290.1 1310.7 1322.9 1330.2 9481.7 9786.4 9798.6 9801.9 9815.0 9538.9 9599.6 9880.0 9897.6 9927.8 2193.1 2242.2 2242.6 2243.0 2243.6 1914.2 1999.5 2003.4 2004.0 2005.8 1753.3 1816.7 1823.0 1826.0 1826.3 2117.1 2199.4 2204.1 2205.1 2209.9 1981.7 1990.0 1998.3 2000.7 2004.4 8584.7 9758.3 9767.1 9777.8 10076.4 4494.7 5373.2 5532.5 5537.4 5550.4 3048.4 3239.9 3290.3 3295.0 3306.2 1028.9 1055.0 1065.4 1066.2 1076.2 14000.4 14130.9 14193.9 14251.6 14291.2 4500.6 4620.9 4694.0 4700.4 4710.5 10997.1 10998.7 11012.6 11020.7 11032.5 5167.8 5240.9 5256.9 5262.8 5264.9 4637.0 4778.3 4789.6 4850.6 4851.9 3823.5 3876.3 3893.0 3949.1 3959.0 1150.3 1161.5 1176.4 1197.0 1202.8 713.3 718.0 723.5 731.2 743.3 5057.5 5078.4 5244.6 5255.5 5348.6 453.3 543.9 544.5 558.6 561.0 4053.2 4196.9 4205.8 4253.5 4348.2 12429.7 12525.4 12735.8 12771.0 12789.4 12263.8 12579.6 12653.4 12654.8 12779.9 7407.2 7593.4 7602.3 7609.5 7613.5 5714.2 5894.9 6010.4 6036.8 6076.9 11040.4 11055.0 11128.7 11197.0 11266.7 11241.2 11314.2 11375.4 11386.4 11393.7 8091.2 8254.8 8306.8 8522.5 8538.3 9013.5 9189.0 9189.4 9193.7 9220.9 7351.0 7605.4 7722.3 7791.4 7820.3 7232.7 7563.0 7563.7 7714.0 7931.6 6996.9 7003.0 7042.6 7162.2 7165.4 4158.6 5143.4 5158.4 5158.8 5354.2 5245.7 5265.5 5401.1 5412.8 5456.7 21:07:28 INFO - PID 607 | 21:07:28 INFO - PID 607 | [#4] prototype.html Cycles:180 Average:4474.70 Median:5100.69 stddev:1300.87 (25.5%) stddev-sans-first:1267.78 21:07:28 INFO - PID 607 | Values: 384.7 385.1 389.4 389.5 389.8 5116.8 5127.8 5128.4 5151.5 5153.6 4820.9 5047.9 5059.4 5072.7 5086.8 3880.3 3938.3 3943.1 3949.0 3952.9 3929.3 3931.3 3952.5 3957.4 3965.8 3905.2 3906.1 3912.4 3912.9 3930.5 3800.8 3882.9 3887.3 3909.9 3935.2 3411.6 3464.1 3466.0 3466.7 3467.2 4958.7 4977.3 4980.5 4984.8 4989.6 4462.6 4533.5 4566.3 4576.0 4595.5 5352.8 5358.7 5364.9 5377.8 5384.5 3853.4 3866.6 3869.8 3874.2 3874.3 5551.0 5634.2 5652.9 5708.5 5719.6 3932.1 3940.1 3958.1 3959.8 3960.8 4024.1 4024.5 4028.0 4031.6 4035.1 4458.5 4578.9 4580.2 4587.0 4591.1 5338.7 5346.9 5385.8 5401.7 5403.6 1365.2 1376.1 1381.6 1383.9 1386.7 891.5 929.5 945.6 946.9 949.0 4721.8 4730.0 4730.7 4731.7 4751.6 5569.5 5574.7 5576.3 5591.5 5594.8 4594.0 4695.9 4708.9 4714.6 4716.3 2915.3 2954.8 2968.7 2970.3 2986.4 5229.3 5258.9 5277.5 5313.4 5329.4 5488.5 5747.7 5751.7 5762.8 5781.9 5076.3 5114.6 5200.0 5238.6 5248.4 5553.1 5557.4 5564.2 5564.9 5578.5 5299.4 5421.6 5449.2 5514.2 5539.3 5232.9 5264.2 5269.5 5285.6 5289.4 3921.9 3944.5 3949.8 3962.0 3968.1 5368.4 5588.8 5595.0 5608.8 5615.2 5395.9 5418.9 5425.4 5439.3 5441.8 5410.6 5417.2 5419.6 5430.9 5444.5 5164.2 5313.8 5338.2 5349.7 5362.0 5410.4 5427.8 5431.7 5447.4 5455.3 5268.2 5276.2 5283.6 5291.6 5306.0 21:07:28 INFO - PID 607 | 21:07:28 INFO - PID 607 | [#5] yui.html Cycles:180 Average:15165.55 Median:3078.70 stddev:18001.96 (584.7%) stddev-sans-first:18019.39 21:07:28 INFO - PID 607 | Values: 633.9 748.6 772.1 777.8 787.7 10490.9 14778.6 15221.1 15252.5 15348.8 15050.0 15197.3 15235.4 15286.4 15294.0 637.4 655.9 879.5 893.8 897.8 869.7 886.8 887.8 896.3 897.0 954.6 960.1 960.4 960.6 960.9 949.1 955.2 955.4 955.5 956.4 705.6 710.3 712.0 712.2 712.2 13525.7 13676.2 13730.9 14211.9 14620.0 14961.2 15207.2 15378.1 15402.2 15409.4 11992.4 12252.6 12278.4 12364.4 12368.3 3013.1 3033.8 3038.4 3039.9 3040.9 71332.0 72543.3 73152.0 73328.6 74318.3 12846.9 12848.6 12999.9 13001.7 13077.1 22770.4 22970.5 23195.5 23386.3 23413.5 6023.5 6078.3 6092.1 6239.9 6320.3 3004.9 3072.0 3075.4 3075.6 3081.8 3486.4 3544.2 3579.1 3579.4 3602.5 712.0 726.2 728.1 730.3 730.8 584.5 601.3 604.8 608.0 627.2 8983.1 9768.4 10107.6 10254.1 10452.3 557.6 560.1 561.9 565.6 570.6 4878.3 5142.0 5185.8 5314.2 5377.9 65678.3 66170.0 67001.7 67113.7 68017.3 42016.0 57064.4 57359.4 57984.4 58200.7 33821.3 36883.4 50877.2 51863.0 53413.7 10310.3 10584.6 11156.8 11308.8 11325.5 25845.1 26357.7 26671.3 26679.9 27101.5 30576.5 30900.4 31094.1 31217.8 31424.8 13439.4 13690.7 13701.7 13702.4 13934.4 13814.7 14148.1 14302.4 15303.3 15676.9 13199.9 13660.2 13735.0 14009.4 14884.3 13368.9 13541.1 13957.7 15085.5 15219.3 14066.7 14268.0 14342.6 14488.9 14545.2 9778.2 9890.3 10070.9 10293.6 10507.2 11242.2 11870.2 12162.7 12321.7 12638.7 21:07:28 INFO - PID 607 | -------- Summary: end -------- 21:07:28 INFO - PID 607 | 21:07:29 INFO - TEST-INFO | 607: exit 0 21:07:29 INFO - TEST-OK | dromaeo_css | took 1121539ms 21:07:29 INFO - TEST-START | kraken 21:07:29 INFO - operating with platform_type : linux_ 21:07:29 INFO - Initialising browser for kraken test... 21:07:29 INFO - TEST-INFO | started process 941 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuApKm8/profile http://localhost:53959/getInfo.html) 21:07:33 INFO - PID 941 | __metrics Screen width/height:1600/1200 21:07:33 INFO - PID 941 | colorDepth:24 21:07:33 INFO - PID 941 | Browser inner width/height: 1024/697 21:07:33 INFO - PID 941 | __metrics 21:07:33 INFO - PID 941 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:07:33 INFO - PID 941 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:07:35 INFO - TEST-INFO | 941: exit 0 21:07:35 INFO - Browser initialized. 21:07:35 INFO - Running cycle 1/1 for kraken test... 21:07:35 INFO - TEST-INFO | started process 1038 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuApKm8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:07:47 INFO - PID 1038 | RSS: Main: 156889088 21:07:47 INFO - PID 1038 | 21:07:49 INFO - PID 1038 | Cycle 1(1): loaded http://localhost:53959/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53959/tests/kraken/driver.html?testName=audio-beat-detection) 21:07:50 INFO - PID 1038 | RSS: Main: 227938304 21:07:50 INFO - PID 1038 | 21:07:53 INFO - PID 1038 | Cycle 1(1): loaded http://localhost:53959/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53959/tests/kraken/driver.html?testName=audio-dft) 21:07:54 INFO - PID 1038 | RSS: Main: 189784064 21:07:54 INFO - PID 1038 | 21:07:57 INFO - PID 1038 | Cycle 1(1): loaded http://localhost:53959/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53959/tests/kraken/driver.html?testName=audio-fft) 21:07:57 INFO - PID 1038 | RSS: Main: 271953920 21:07:57 INFO - PID 1038 | 21:08:00 INFO - PID 1038 | Cycle 1(1): loaded http://localhost:53959/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53959/tests/kraken/driver.html?testName=audio-oscillator) 21:08:00 INFO - PID 1038 | RSS: Main: 183119872 21:08:00 INFO - PID 1038 | 21:08:02 INFO - PID 1038 | Cycle 1(1): loaded http://localhost:53959/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53959/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:08:03 INFO - PID 1038 | RSS: Main: 185020416 21:08:03 INFO - PID 1038 | 21:08:06 INFO - PID 1038 | Cycle 1(1): loaded http://localhost:53959/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53959/tests/kraken/driver.html?testName=imaging-darkroom) 21:08:07 INFO - PID 1038 | RSS: Main: 245555200 21:08:07 INFO - PID 1038 | 21:08:10 INFO - PID 1038 | Cycle 1(1): loaded http://localhost:53959/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53959/tests/kraken/driver.html?testName=imaging-desaturate) 21:08:11 INFO - PID 1038 | RSS: Main: 244682752 21:08:11 INFO - PID 1038 | 21:08:14 INFO - PID 1038 | Cycle 1(1): loaded http://localhost:53959/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53959/tests/kraken/driver.html?testName=json-parse-financial) 21:08:14 INFO - PID 1038 | RSS: Main: 241664000 21:08:14 INFO - PID 1038 | 21:08:16 INFO - PID 1038 | Cycle 1(1): loaded http://localhost:53959/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53959/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:08:17 INFO - PID 1038 | RSS: Main: 207302656 21:08:17 INFO - PID 1038 | 21:08:18 INFO - PID 1038 | Cycle 1(1): loaded http://localhost:53959/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53959/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:08:19 INFO - PID 1038 | RSS: Main: 193298432 21:08:19 INFO - PID 1038 | 21:08:21 INFO - PID 1038 | Cycle 1(1): loaded http://localhost:53959/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53959/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:08:22 INFO - PID 1038 | RSS: Main: 221126656 21:08:22 INFO - PID 1038 | 21:08:24 INFO - PID 1038 | Cycle 1(1): loaded http://localhost:53959/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53959/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:08:25 INFO - PID 1038 | RSS: Main: 225382400 21:08:25 INFO - PID 1038 | 21:08:28 INFO - PID 1038 | Cycle 1(1): loaded http://localhost:53959/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53959/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:08:29 INFO - PID 1038 | RSS: Main: 207777792 21:08:29 INFO - PID 1038 | 21:08:31 INFO - PID 1038 | Cycle 1(1): loaded http://localhost:53959/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53959/tests/kraken/driver.html?testName=ai-astar) 21:08:31 INFO - PID 1038 | RSS: Main: 276262912 21:08:31 INFO - PID 1038 | 21:08:31 INFO - PID 1038 | __start_tp_report 21:08:31 INFO - PID 1038 | _x_x_mozilla_page_load 21:08:31 INFO - PID 1038 | _x_x_mozilla_page_load_details 21:08:31 INFO - PID 1038 | |i|pagename|runs| 21:08:31 INFO - PID 1038 | |0;ai-astar;109;111;112;112;110;112;109;110;111;110 21:08:31 INFO - PID 1038 | |1;audio-beat-detection;154;126;122;170;125;124;122;126;154;123 21:08:31 INFO - PID 1038 | |2;audio-dft;164;162;162;161;162;163;162;162;163;161 21:08:31 INFO - PID 1038 | |3;audio-fft;75;75;74;118;74;77;75;75;95;75 21:08:31 INFO - PID 1038 | |4;audio-oscillator;84;84;110;83;83;84;96;83;84;103 21:08:31 INFO - PID 1038 | |5;imaging-gaussian-blur;113;113;113;114;114;113;113;113;113;114 21:08:31 INFO - PID 1038 | |6;imaging-darkroom;149;149;149;148;148;149;149;148;148;148 21:08:31 INFO - PID 1038 | |7;imaging-desaturate;95;94;95;94;94;94;93;94;94;94 21:08:31 INFO - PID 1038 | |8;json-parse-financial;53;53;52;52;53;54;54;54;53;54 21:08:31 INFO - PID 1038 | |9;json-stringify-tinderbox;56;56;56;56;56;56;56;57;56;55 21:08:31 INFO - PID 1038 | |10;stanford-crypto-aes;80;80;81;80;81;81;82;86;82;81 21:08:31 INFO - PID 1038 | |11;stanford-crypto-ccm;152;136;137;140;132;129;129;129;220;135 21:08:31 INFO - PID 1038 | |12;stanford-crypto-pbkdf2;184;195;200;190;190;193;195;189;193;191 21:08:31 INFO - PID 1038 | |13;stanford-crypto-sha256-iterative;70;71;71;70;70;69;71;72;69;69 21:08:31 INFO - PID 1038 | __end_tp_report 21:08:31 INFO - PID 1038 | __start_cc_report 21:08:31 INFO - PID 1038 | _x_x_mozilla_cycle_collect,1982 21:08:31 INFO - PID 1038 | __end_cc_report 21:08:31 INFO - PID 1038 | __startTimestamp1493093311583__endTimestamp 21:08:31 INFO - PID 1038 | 21:08:31 INFO - PID 1038 | ------- Summary: start ------- 21:08:31 INFO - PID 1038 | Number of tests: 14 21:08:31 INFO - PID 1038 | 21:08:31 INFO - PID 1038 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.00 stddev:1.17 (1.1%) stddev-sans-first:1.09 21:08:31 INFO - PID 1038 | Values: 109.0 111.0 112.0 112.0 110.0 112.0 109.0 110.0 111.0 110.0 21:08:31 INFO - PID 1038 | 21:08:31 INFO - PID 1038 | [#1] audio-beat-detection Cycles:10 Average:134.60 Median:126.00 stddev:17.67 (14.0%) stddev-sans-first:17.29 21:08:31 INFO - PID 1038 | Values: 154.0 126.0 122.0 170.0 125.0 124.0 122.0 126.0 154.0 123.0 21:08:31 INFO - PID 1038 | 21:08:31 INFO - PID 1038 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.00 stddev:0.92 (0.6%) stddev-sans-first:0.71 21:08:31 INFO - PID 1038 | Values: 164.0 162.0 162.0 161.0 162.0 163.0 162.0 162.0 163.0 161.0 21:08:31 INFO - PID 1038 | 21:08:31 INFO - PID 1038 | [#3] audio-fft Cycles:10 Average:81.30 Median:75.00 stddev:14.37 (19.2%) stddev-sans-first:15.06 21:08:31 INFO - PID 1038 | Values: 75.0 75.0 74.0 118.0 74.0 77.0 75.0 75.0 95.0 75.0 21:08:31 INFO - PID 1038 | 21:08:31 INFO - PID 1038 | [#4] audio-oscillator Cycles:10 Average:89.40 Median:84.00 stddev:9.96 (11.9%) stddev-sans-first:10.37 21:08:31 INFO - PID 1038 | Values: 84.0 84.0 110.0 83.0 83.0 84.0 96.0 83.0 84.0 103.0 21:08:31 INFO - PID 1038 | 21:08:31 INFO - PID 1038 | [#5] imaging-gaussian-blur Cycles:10 Average:113.30 Median:113.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 21:08:31 INFO - PID 1038 | Values: 113.0 113.0 113.0 114.0 114.0 113.0 113.0 113.0 113.0 114.0 21:08:31 INFO - PID 1038 | 21:08:31 INFO - PID 1038 | [#6] imaging-darkroom Cycles:10 Average:148.50 Median:149.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 21:08:31 INFO - PID 1038 | Values: 149.0 149.0 149.0 148.0 148.0 149.0 149.0 148.0 148.0 148.0 21:08:31 INFO - PID 1038 | 21:08:31 INFO - PID 1038 | [#7] imaging-desaturate Cycles:10 Average:94.10 Median:94.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 21:08:31 INFO - PID 1038 | Values: 95.0 94.0 95.0 94.0 94.0 94.0 93.0 94.0 94.0 94.0 21:08:31 INFO - PID 1038 | 21:08:31 INFO - PID 1038 | [#8] json-parse-financial Cycles:10 Average:53.20 Median:53.50 stddev:0.79 (1.5%) stddev-sans-first:0.83 21:08:31 INFO - PID 1038 | Values: 53.0 53.0 52.0 52.0 53.0 54.0 54.0 54.0 53.0 54.0 21:08:31 INFO - PID 1038 | 21:08:31 INFO - PID 1038 | [#9] json-stringify-tinderbox Cycles:10 Average:56.00 Median:56.00 stddev:0.47 (0.8%) stddev-sans-first:0.50 21:08:31 INFO - PID 1038 | Values: 56.0 56.0 56.0 56.0 56.0 56.0 56.0 57.0 56.0 55.0 21:08:31 INFO - PID 1038 | 21:08:31 INFO - PID 1038 | [#10] stanford-crypto-aes Cycles:10 Average:81.40 Median:81.00 stddev:1.78 (2.2%) stddev-sans-first:1.81 21:08:31 INFO - PID 1038 | Values: 80.0 80.0 81.0 80.0 81.0 81.0 82.0 86.0 82.0 81.0 21:08:31 INFO - PID 1038 | 21:08:31 INFO - PID 1038 | [#11] stanford-crypto-ccm Cycles:10 Average:143.90 Median:136.50 stddev:27.63 (20.2%) stddev-sans-first:29.15 21:08:31 INFO - PID 1038 | Values: 152.0 136.0 137.0 140.0 132.0 129.0 129.0 129.0 220.0 135.0 21:08:31 INFO - PID 1038 | 21:08:31 INFO - PID 1038 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:192.00 Median:193.00 stddev:4.29 (2.2%) stddev-sans-first:3.44 21:08:31 INFO - PID 1038 | Values: 184.0 195.0 200.0 190.0 190.0 193.0 195.0 189.0 193.0 191.0 21:08:31 INFO - PID 1038 | 21:08:31 INFO - PID 1038 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.20 Median:70.50 stddev:1.03 (1.5%) stddev-sans-first:1.09 21:08:31 INFO - PID 1038 | Values: 70.0 71.0 71.0 70.0 70.0 69.0 71.0 72.0 69.0 69.0 21:08:31 INFO - PID 1038 | -------- Summary: end -------- 21:08:31 INFO - PID 1038 | 21:08:32 INFO - TEST-INFO | 1038: exit 0 21:08:33 INFO - TEST-OK | kraken | took 63727ms 21:08:33 INFO - SUITE-END | took 1185s 21:08:33 INFO - Completed test suite (00:19:45) 21:08:33 INFO - javascript benchmark 21:08:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6559.336509397175, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2701.635279237303, 2701.94596108078, 2707.945841083177, 2732.8633568321584, 2747.162115554755, 4858.781354839032, 5022.347094877661, 5049.015441988814, 5093.3124028256225, 5142.845714628563, 4999.25011248313, 5001.424836143845, 5068.4424713281505, 5112.335396398463, 5156.716380599066, 4500.234960056782, 4513.774311284439, 4516.983678672305, 4609.262517997121, 4627.051454451829, 4593.966357569553, 4619.237825758746, 4627.282771170457, 4668.789904454291, 4703.365045718819, 4419.359192917042, 4481.8655440336515, 4489.955100448987, 4541.636669066466, 4613.1696294666945, 4565.771711414416, 4567.817287308504, 4581.702189357681, 4630.536946305376, 4632.930506042412, 4537.1833070047705, 4542.6138778203895, 4562.498125206258, 4593.150267200579, 4618.861434156981, 4894.583960363373, 4958.206686930074, 5089.389273287192, 5100.38795344561, 5101.2093125565225, 5352.652077614982, 5353.116735738598, 5353.9196912046355, 5355.571554275649, 5358.196270559409, 5367.651102678353, 5368.141097424394, 5369.140937449989, 5372.758225879845, 5373.35519737634, 4954.851354459372, 5007.073691367109, 5007.824726134604, 5010.448850626428, 5019.3976722793495, 5439.5104440600535, 5488.53347465462, 5492.286002819608, 5495.670259784426, 5496.972515137399, 5258.894822103536, 5370.355557333145, 5435.157550579666, 5443.455654434525, 5445.809396671098, 5494.972525137348, 5511.614187006951, 5515.558755299567, 5517.2551705520045, 5528.889422211533, 5460.290162278958, 5471.972640136853, 5482.259894914216, 5487.5609951203805, 5514.889702205934, 5279.340082489689, 5357.517823395913, 5365.785368585291, 5421.26812880264, 5481.451854814487, 4501.864944051684, 4504.549545045535, 4517.457905051349, 4544.2274813281165, 4547.1815073287125, 3899.941500877489, 3917.7845218513257, 3928.724989250782, 3931.1154990126993, 3959.0, 4497.190505708938, 4583.19794036049, 4584.472785629629, 4683.344331793552, 4719.244920812722, 5393.6763794172475, 5400.702961337086, 5404.8108316208745, 5408.269883565668, 5409.377921538995, 4590.242609969385, 4596.10375976688, 4598.563136502027, 4598.839040633562, 4602.585767280961, 4765.571098601143, 4767.332573439721, 4772.236442169236, 4773.904521909542, 4776.068666609977, 5001.974990125026, 5062.291279220985, 5097.8725531861255, 5102.158143906214, 5112.923306150336, 5402.837914862561, 5405.054115529845, 5406.972965135149, 5408.513233808976, 5408.78364865401, 5103.821366252163, 5114.9232761507865, 5152.922706159336, 5163.4578369270685, 5204.0892843752945, 5442.537384322219, 5447.237386765777, 5454.618176727591, 5456.48163424474, 5460.590455715757, 5300.9734951325, 5517.668939863621, 5529.4470552944385, 5531.170324451365, 5588.720563971867, 5218.0, 5219.1388420910125, 5286.788528458818, 5299.8410047698635, 5359.222912677562, 5326.520613144836, 5327.493888080626, 5333.4133245343755, 5333.599980001438, 5368.812091576776, 5254.737263136904, 5254.816081437284, 5258.2375555544995, 5266.710330931835, 5311.176767601028, 5185.066687996046, 5255.3693556771905, 5259.815906443256, 5278.155495120763, 5358.946410536, 5210.635255532076, 5231.398389185292, 5233.685978841282, 5265.815696450606, 5283.049051170826], "value": 4945.957843832023, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [602.4878852974972, 678.4640134293908, 694.3611877073092, 1040.0171837613454, 1059.6556119261243, 27134.0, 27758.722412775867, 27777.166684999433, 27785.861070694642, 27810.165695029133, 29993.700062999364, 30613.846930765372, 30730.23174420635, 30800.383992320196, 31050.689493105063, 7091.645417729132, 7197.928020719804, 7206.891896621555, 7213.747518836842, 7221.747238846641, 5618.887622247553, 7146.892796608029, 7247.130344358658, 7251.7461888833905, 7265.818354541126, 5798.246227990377, 7203.423726101899, 7391.926080739205, 7399.556026638392, 7400.666969986363, 7384.963075184616, 7408.888866667005, 7435.516691415095, 7438.404927605833, 7443.06961629799, 7302.415806735448, 7383.630818459109, 7384.261573842627, 7393.482456228066, 7393.482456228066, 24312.513749724905, 25178.0, 31029.379412411625, 31858.04425867228, 31925.52111718326, 3034.4386288536693, 3064.8007879487764, 3071.5699802027734, 3073.4621441247914, 3073.554334621467, 25193.87403062991, 25230.495390092277, 25235.747642523707, 25256.747432525808, 25263.242102736946, 3201.9039428817173, 3210.855511501988, 3211.983940080308, 3230.095573239497, 3230.2570408806105, 141693.0, 141814.0, 141885.2905735475, 142006.0, 142165.0, 42331.15337693229, 42370.364444533356, 42444.363334550006, 42476.0, 42521.36217956733, 44342.77828610836, 44355.33466997997, 44434.445244380375, 44450.33324500135, 44460.3330950036, 10128.139108175741, 10230.07929286353, 10235.078842904175, 10239.0, 10240.539175737109, 7938.126806051329, 7948.880766788503, 7948.960255198803, 7950.363970882316, 7953.12515623281, 10368.118709909591, 11950.34273114987, 12165.939170304091, 12229.816552751716, 12328.32194229308, 4414.24109931293, 4418.756968366706, 4458.665600080007, 4524.23088075028, 4836.46798852126, 909.072745799281, 910.6038873090226, 915.555955361649, 918.9678361257323, 924.7780532672244, 21108.47228819261, 21670.674939875913, 21698.783012169675, 21701.565968680537, 21837.235696750537, 955.7801705607749, 965.1410244882061, 965.1506674126723, 974.5273542331963, 992.4144754594823, 11488.368139752394, 11496.712582185512, 11500.079993600491, 11518.136139789382, 11653.126015548867, 158635.0, 158803.0, 158917.0, 158937.205313975, 159041.0, 41060.178796423905, 41323.1735365291, 41326.173476530304, 41367.0, 41452.79273603673, 1187.3779302791093, 1213.6116442738416, 1220.4020030185322, 1225.2158618484177, 1225.4424236972156, 19512.0, 19718.704219436433, 20330.491737706674, 21056.789432105485, 21336.359909202747, 29836.0, 29997.850010749808, 29999.250018749706, 30016.0, 30029.0, 155236.2238188802, 155259.0, 155299.0, 155831.0, 155868.0, 28763.568546472237, 28838.279043024093, 29221.0, 30127.397452051275, 30177.698223017487, 37639.059023524635, 37690.43464348092, 37737.62262377451, 37818.81090594529, 37883.431748523246, 25856.0, 27275.86362068177, 28584.142475725763, 29384.26539336534, 29860.850695746383, 28263.717362826108, 28291.43417131687, 28350.858245708638, 29422.411551769274, 29862.25344366408, 31530.36939261248, 32055.839720801247, 32108.19729506781, 32179.51730724088, 32246.83876580602, 27926.72073279241, 28408.57387139236, 28440.57339139956, 28712.425751485272, 29507.85246073756, 20823.0, 22734.20430284932, 22762.317130486113, 22920.426989324733, 22954.42613934665], "value": 14249.208618263574, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [405.57617289932017, 409.3573090248308, 417.5615603616203, 434.5806296923468, 434.9064951035527, 16435.917820410898, 16454.21553042801, 16851.07319097449, 17128.571785705364, 17172.14139293035, 15333.386664533406, 15450.5364839055, 15490.225488725548, 15550.533483995498, 15660.295286712097, 5529.612927095105, 5540.806071787489, 5751.741171647265, 5765.509931655814, 5781.219535362735, 5551.77792888284, 5673.177389278552, 5696.344920334152, 5696.490430036044, 5700.7719691212305, 5619.241402410684, 5647.971760141214, 5656.802011929583, 5661.943380566204, 5667.0932650775885, 5510.559155267589, 5646.6894320812335, 5656.321241451032, 5657.632253903504, 5682.943170568324, 5070.112730272188, 5076.898462030738, 5108.310378098946, 5115.028144652541, 5115.795368185268, 20421.183152673875, 20445.897770511052, 20629.277975270943, 20775.8961205193, 20798.0, 1684.6967545841744, 1716.416418417744, 1719.389616686071, 1726.47342560519, 1726.896386216831, 13768.955665221518, 13791.51729689466, 13928.025038247326, 13993.3702983366, 14002.719945601133, 1904.6952487601918, 1916.4059141666128, 1966.9378535590906, 1968.9507762305914, 1976.3379267945256, 66190.0, 76423.61788191079, 90895.54552227263, 91715.54142229313, 91939.54030229873, 10527.84208236877, 10568.947155264328, 10571.62999295021, 10765.784684306427, 10784.191185661106, 15021.0, 15044.774328385083, 15051.322690478735, 15061.623459413384, 15073.170975596448, 6646.169228846395, 6655.5341126121675, 6806.217285012287, 6838.897416538756, 6894.551854129466, 5870.090136028923, 5959.28488581373, 6083.8479038023515, 6107.664078475637, 6141.140240366352, 6751.291114433012, 6765.023389708513, 6786.8303292417095, 6857.382835544725, 6888.726720182328, 1952.4630726550029, 1971.8323942464765, 1985.5631761012555, 1994.4016794961453, 2025.3721346382667, 887.4896934262824, 913.0595486648763, 914.1635403605759, 915.2677857713802, 937.2314701944476, 16729.54221952377, 17153.0, 17765.111744412727, 17819.643607127786, 18032.90983545074, 901.3420203251663, 901.5627420700955, 902.963881444748, 905.3481493324796, 918.3204428722697, 9242.3530352876, 9637.855432168522, 9705.6603018894, 9738.513074346254, 9774.657886973922, 366592.0, 373487.0, 376546.0, 378359.0, 382019.0, 78055.60972195216, 80438.0, 80934.19065809384, 83636.0, 85009.57495212484, 1046.246702374274, 1068.8289873620183, 1092.6066616018227, 1098.1653943003375, 1100.1254003067581, 14507.92746036263, 14646.780298295747, 14676.266186690837, 14785.260736963324, 15277.465288714842, 38545.807270963465, 40383.0, 40786.38820417756, 40956.59043409528, 41852.37221441742, 51664.48335516597, 51908.480915191874, 52054.73972630112, 54081.0, 56144.15783763328, 11243.7751244973, 11349.659510214708, 11410.0, 12324.876751232372, 12864.163829351062, 13004.739905202032, 13132.146410483288, 13203.603891883258, 13311.80032299497, 13414.597562073153, 11324.830127547928, 11326.32042077478, 11507.021903137993, 11545.942270288595, 11595.5941542049, 10245.180385569285, 10283.537240824331, 10386.636467723594, 11049.0, 11209.943950280196, 11139.665810025712, 11618.128640352177, 11749.706257343634, 11920.165588408729, 12141.817872731739, 12182.451789669663, 12200.450979705756, 12253.632391028283, 12746.936265318614, 12749.023901295313, 10810.945945270223, 10873.184511161537, 10918.0, 11065.944670276596, 11354.602588909349], "value": 8946.392410913191, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1250.9624711258662, 1290.1485019886877, 1310.7050913544454, 1322.9404676789557, 1330.201878872676, 9481.715548533537, 9786.412815231091, 9798.608055677772, 9801.901980980188, 9814.950925245374, 9538.856917146231, 9599.616015359396, 9880.0, 9897.604095836175, 9927.801443971117, 2193.0898677049004, 2242.248846636379, 2242.551489702058, 2242.990654205606, 2243.55128974205, 1914.176903931316, 1999.5201151723554, 2003.4390370696156, 2003.9599208015832, 2005.8395328373695, 1753.32496988659, 1816.6729988602046, 1823.0155715913456, 1826.0, 1826.269492203116, 2117.100232401231, 2199.4061603367163, 2204.1293688992837, 2205.106931692667, 2209.928184830356, 1981.682930731076, 1989.9602007959904, 1998.3105828489147, 2000.6895483458359, 2004.4387571480008, 8584.656613735444, 9758.268129890215, 9767.072128147815, 9777.755556111082, 10076.445795481246, 4494.662900282459, 5373.2208829719475, 5532.474414930575, 5537.390887002426, 5550.4449555044575, 3048.420800047984, 3239.9028029159163, 3290.3090351026312, 3294.96705032949, 3306.173456635841, 1028.9073983341461, 1055.0399136785488, 1065.3767545985609, 1066.1843689577402, 1076.2036093290988, 14000.369983350673, 14130.858691413057, 14193.929030354886, 14251.643708907257, 14291.213983230919, 4500.639948804088, 4620.907581848344, 4694.0, 4700.435947686231, 4710.458297295855, 10997.12023038155, 10998.725031874266, 11012.559497620166, 11020.724481887857, 11032.50353734084, 5167.767450464738, 5240.868978275497, 5256.92114618281, 5262.7631756571045, 5264.894702105937, 4637.0, 4778.331033655291, 4789.568938795525, 4850.587700045465, 4851.902961940741, 3823.5029446172375, 3876.3022655922205, 3893.0, 3949.0917089069676, 3959.0, 1150.2523359816187, 1161.5411912294596, 1176.3824740981152, 1196.9940150299192, 1202.8316035755001, 713.3294702979183, 717.9605121718251, 723.5369363607296, 731.1518638379455, 743.3124359967117, 5057.519535644108, 5078.3905931287745, 5244.5542128918705, 5255.474452554714, 5348.572114230852, 453.31593131516576, 543.8531596468931, 544.5317027356471, 558.6452602597299, 560.9719514024282, 4053.2298863215897, 4196.874093777192, 4205.789710514462, 4253.510846252659, 4348.152110338454, 12429.689257768629, 12525.373731313397, 12735.808962865565, 12771.0, 12789.360531973363, 12263.75472490563, 12579.622611321674, 12653.430595623218, 12654.81017784734, 12779.872201278054, 7407.185209626937, 7593.392528597588, 7602.315791578784, 7609.543427394374, 7613.543187408663, 5714.228579141763, 5894.882102358015, 6010.398960103955, 6036.849078773066, 6076.8784624308155, 11040.392778397265, 11055.0, 11128.666140015812, 11197.048250898439, 11266.66200014001, 11241.213115082193, 11314.208005439541, 11375.374354410256, 11386.373749443861, 11393.658190254306, 8091.150429205084, 8254.83490330202, 8306.792330191794, 8522.531260780717, 8538.292341531842, 9013.549322533716, 9188.95405522968, 9189.402688825205, 9193.678221262491, 9220.861687074834, 7350.96324518374, 7605.391568674382, 7722.3049925506975, 7791.415643826623, 7820.257075577811, 7232.74685386009, 7563.0, 7563.697452102075, 7713.961430192813, 7931.5637639930355, 6996.860062798613, 7003.019577259086, 7042.577445353295, 7162.212156662658, 7165.426765858823, 4158.604932531404, 5143.3570803649545, 5158.38099428071, 5158.845234642967, 5354.196870469305, 5245.674054241597, 5265.515799534121, 5401.108817045144, 5412.78348866041, 5456.699881506396], "value": 4527.031506454792, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.6691845013288, 385.0623731214493, 389.36922186058587, 389.53450626501325, 389.7564022485946, 5116.795328186873, 5127.846164615058, 5128.410232823227, 5151.536361727449, 5153.587712982961, 4820.879478013051, 5047.949520504794, 5059.443461219272, 5072.746362681861, 5086.821961231358, 3880.301545721776, 3938.2714197873343, 3943.0536671198993, 3948.9802550987206, 3952.940705889414, 3929.332013557702, 3931.331673615492, 3952.505936757905, 3957.4063890416523, 3965.8017099145072, 3905.1799122184375, 3906.1211227473877, 3912.3740201567753, 3912.941305880414, 3930.547986981491, 3800.771953682774, 3882.9223415531533, 3887.3391523441082, 3909.9218015639526, 3935.2129574085297, 3411.6417776133644, 3464.133966508373, 3466.0, 3466.7346418557045, 3467.219875528011, 4958.677685950402, 4977.328060711794, 4980.501949805027, 4984.750762461898, 4989.57588604969, 4462.576055274743, 4533.455985281755, 4566.337881007235, 4575.954240457586, 4595.517470665565, 5352.759125839347, 5358.651687640291, 5364.892702145935, 5377.838664840022, 5384.542313903284, 3853.402722577977, 3866.5553461352024, 3869.787161706105, 3874.1670540833575, 3874.341361968472, 5550.972245138749, 5634.211210430502, 5652.869426114752, 5708.543316534668, 5719.628224165416, 3932.095618007817, 3940.0937784309194, 3958.0698535844053, 3959.762414255154, 3960.821763020613, 4024.1348110155873, 4024.531046168186, 4027.9798601006805, 4031.5968403160036, 4035.1324465240114, 4458.464984201852, 4578.88552786183, 4580.198465268565, 4586.954130458719, 4591.058832939306, 5338.652987555796, 5346.91979620306, 5385.7576409061685, 5401.675899446046, 5403.594730395236, 1365.1672479787321, 1376.1330361871956, 1381.5648070857649, 1383.861613838608, 1386.682651481097, 891.4666773150171, 929.484136304344, 945.5603144537686, 946.9100435458621, 948.9857652135223, 4721.787519561628, 4729.95270047302, 4730.692504987165, 4731.739754313546, 4751.572358487752, 5569.526590239875, 5574.665520068809, 5576.2713558796095, 5591.524720398812, 5594.83891601244, 4594.0, 4695.906081878344, 4708.9058218835435, 4714.619117345718, 4716.29255611661, 2915.3003279212835, 2954.8079374840568, 2968.717971792676, 2970.301979034925, 2986.4475072111295, 5229.267902493654, 5258.868528286824, 5277.4986376294955, 5313.362396512366, 5329.413764485904, 5488.53347465462, 5747.712614369265, 5751.741171647286, 5762.798302059407, 5781.88436231273, 5076.289319495274, 5114.5652619527755, 5200.0, 5238.5547228486, 5248.448912864094, 5553.111502159797, 5557.416471270459, 5564.221009058654, 5564.860878478071, 5578.470045345685, 5299.364076310867, 5421.5933804964, 5449.209864569536, 5514.172874068921, 5539.335279766293, 5232.927249913682, 5264.236685680478, 5269.525742683177, 5285.590793937966, 5289.444608316071, 3921.921471595334, 3944.526656801202, 3949.763014219156, 3961.980190099031, 3968.1071758854027, 5368.409474957673, 5588.804391846266, 5594.992901277809, 5608.803691870929, 5615.185798059177, 5395.892082158413, 5418.945810541844, 5425.376081750649, 5439.265699130567, 5441.83674489766, 5410.648307860134, 5417.160340147283, 5419.647722897999, 5430.864228394164, 5444.537214336826, 5164.1995490699, 5313.840584782462, 5338.199270109515, 5349.679019258857, 5362.0, 5410.404855465974, 5427.751617128004, 5431.696392865605, 5447.428020057995, 5455.290812194389, 5268.1834315681135, 5276.2349459327415, 5283.622369933469, 5291.629585928948, 5306.0], "value": 4081.422455035748, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [633.9175907132072, 748.5658318175457, 772.0542335638839, 777.8016605765529, 787.732171061839, 10490.947545262272, 14778.556643300692, 15221.08673479592, 15252.542423727306, 15348.846511534895, 15050.021748586334, 15197.316120774563, 15235.390584376639, 15286.388544458236, 15294.0, 637.419947847459, 655.9081728558006, 879.4635272483796, 893.7676204186926, 897.833900728364, 869.6695255802817, 886.8270687215995, 887.786931136529, 896.3143195455482, 896.9730908072768, 954.627695198873, 960.1454705312277, 960.4045491795097, 960.5917485068853, 960.851068084448, 949.0888746803078, 955.2453561686259, 955.3885513271512, 955.4649396338073, 956.4118067388575, 705.6189657584898, 710.2790667472519, 712.0387476906187, 712.2023333866103, 712.2058904321696, 13525.729485410237, 13676.247806370646, 13730.93134534331, 14211.857881421156, 14620.0, 14961.177135257556, 15207.163606001666, 15378.077315361114, 15402.152881591508, 15409.383624655, 11992.400379980965, 12252.571160009356, 12278.38608069593, 12364.44360003802, 12368.319742414164, 3013.1261934039103, 3033.848307584634, 3038.4075105354464, 3039.9240018999703, 3040.9391812163854, 71332.0, 72543.27456725418, 73152.0, 73328.63335683341, 74318.25681743221, 12846.871531284754, 12848.614541563767, 12999.935000325127, 13001.739965200642, 13077.084604077623, 22770.43073923132, 22970.540589188124, 23195.53608927846, 23386.298411047697, 23413.531729365317, 6023.518118550505, 6078.300995385587, 6092.116643086816, 6239.906401403982, 6320.304766475684, 3004.8647810848565, 3072.0476652237876, 3075.384923015406, 3075.646300675406, 3081.7534597232166, 3486.372452958441, 3544.2379888324135, 3579.1410061585552, 3579.391503444421, 3602.513660655778, 712.0280816685188, 726.1685370251139, 728.144430294402, 730.2660825870073, 730.7917243585553, 584.4914924016133, 601.3084952304797, 604.8487878030493, 607.9848003799852, 627.2191122053073, 8983.101689831095, 9768.413895166314, 10107.595696172071, 10254.128399086012, 10452.32059916103, 557.5567423898011, 560.0814663951123, 561.8707697229578, 565.6153815405481, 570.5635189080357, 4878.317035614946, 5142.0, 5185.844424667266, 5314.229436731653, 5377.919331210035, 65678.34321656723, 66170.0, 67001.6649916757, 67113.66443167753, 68017.3198268011, 42016.0, 57064.42935570674, 57359.42640573541, 57984.42015579875, 58200.70899645475, 33821.32357352839, 36883.4467482988, 50877.23684144741, 51863.0, 53413.73293133509, 10310.278280520291, 10584.629537966135, 11156.776864462827, 11308.773824523629, 11325.546978120783, 25845.095421660153, 26357.736422635528, 26671.33321666974, 26679.86660066687, 27101.457970840078, 30576.541351880183, 30900.381992359577, 31094.067177984696, 31217.843910780302, 31424.842875785474, 13439.395227214995, 13690.726185476036, 13701.657458563615, 13702.383392747151, 13934.442622294995, 13814.65463363424, 14148.080374776018, 14302.427902883768, 15303.311350989456, 15676.92161539185, 13199.934000329937, 13660.248686322348, 13735.0, 14009.43962241499, 14884.330205141012, 13368.933155334551, 13541.1198272112, 13957.651058723613, 15085.54743357701, 15219.315130819361, 14066.718665626426, 14268.0, 14342.569722907912, 14488.927555362156, 14545.200013999332, 9778.168855647065, 9890.258230632588, 10070.899291007288, 10293.639722609973, 10507.211959102944, 11242.156838237, 11870.169088163746, 12162.695932601755, 12321.69195770077, 12638.684032899251], "value": 6836.123118008473, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1530.7000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 111.0, 112.0, 112.0, 110.0, 112.0, 109.0, 110.0, 111.0, 110.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 126.0, 122.0, 170.0, 125.0, 124.0, 122.0, 126.0, 154.0, 123.0], "value": 134.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 162.0, 161.0, 162.0, 163.0, 162.0, 162.0, 163.0, 161.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 118.0, 74.0, 77.0, 75.0, 75.0, 95.0, 75.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 110.0, 83.0, 83.0, 84.0, 96.0, 83.0, 84.0, 103.0], "value": 89.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 114.0, 114.0, 113.0, 113.0, 113.0, 113.0, 114.0], "value": 113.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 149.0, 148.0, 148.0, 149.0, 149.0, 148.0, 148.0, 148.0], "value": 148.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 94.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0], "value": 94.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 52.0, 52.0, 53.0, 54.0, 54.0, 54.0, 53.0, 54.0], "value": 53.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 56.0, 56.0, 56.0, 56.0, 56.0, 57.0, 56.0, 55.0], "value": 56.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 81.0, 80.0, 81.0, 81.0, 82.0, 86.0, 82.0, 81.0], "value": 81.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 136.0, 137.0, 140.0, 132.0, 129.0, 129.0, 129.0, 220.0, 135.0], "value": 143.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 195.0, 200.0, 190.0, 190.0, 193.0, 195.0, 189.0, 193.0, 191.0], "value": 192.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 71.0, 70.0, 70.0, 69.0, 71.0, 72.0, 69.0, 69.0], "value": 70.2, "unit": "score"}]}]} 21:08:33 INFO - Return code: 0 21:08:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:08:33 ERROR - # TBPL SUCCESS # 21:08:33 INFO - Running post-action listener: _resource_record_post_action 21:08:33 INFO - [mozharness: 2017-04-25 04:08:33.410964Z] Finished run-tests step (success) 21:08:33 INFO - Running post-run listener: _resource_record_post_run 21:08:33 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 8192; Write bytes: 344858624; Read time: 116; Write time: 201844 21:08:33 INFO - TinderboxPrint: CPU usage
12.9% 21:08:33 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 116 21:08:33 INFO - TinderboxPrint: I/O write bytes / time
344,858,624 / 201,844 21:08:33 INFO - TinderboxPrint: CPU idle
8,347.4 (87.1%) 21:08:33 INFO - TinderboxPrint: CPU user
1,198.6 (12.5%) 21:08:33 INFO - TinderboxPrint: Swap in / out
0 / 0 21:08:33 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 101744640; Read time: 0; Write time: 65068 21:08:33 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 243113984; Read time: 108; Write time: 136776 21:08:34 INFO - Running post-run listener: _upload_blobber_files 21:08:34 INFO - Blob upload gear active. 21:08:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:08:34 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 21:08:34 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'] 21:08:34 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 21:08:34 INFO - (blobuploader) - INFO - Open directory for files ... 21:08:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:08:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:08:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:08:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:08:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:08:35 INFO - (blobuploader) - INFO - Done attempting. 21:08:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:08:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:08:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:09:41 INFO - (blobuploader) - CRITICAL - Unexpected error in client: Traceback (most recent call last): 21:09:41 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 145, in upload_file 21:09:41 INFO - check_status(response) 21:09:41 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 181, in check_status 21:09:41 INFO - ret = requests.head(blob_url) 21:09:41 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/requests/api.py", line 77, in head 21:09:41 INFO - return request('head', url, **kwargs) 21:09:41 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/requests/api.py", line 44, in request 21:09:41 INFO - return session.request(method=method, url=url, **kwargs) 21:09:41 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/requests/sessions.py", line 335, in request 21:09:41 INFO - resp = self.send(prep, **send_kwargs) 21:09:41 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/requests/sessions.py", line 438, in send 21:09:41 INFO - r = adapter.send(request, **kwargs) 21:09:41 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/requests/adapters.py", line 327, in send 21:09:41 INFO - raise ConnectionError(e) 21:09:41 INFO - ConnectionError: HTTPConnectionPool(host='mozilla-releng-blobs.s3.amazonaws.com', port=80): Max retries exceeded with url: /blobs/Firefox-Non-PGO/sha512/466a69218850e692c4f790131fbc304fa402f033fedaad717b756342f13fa3589d4c56193cc51943ed4b7c337318e4675c248a31e88a7cecddd57571935c60e1 (Caused by : [Errno 110] Connection timed out) 21:09:41 INFO - (blobuploader) - INFO - Done attempting. 21:09:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 21:09:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:09:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:09:42 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 21:09:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:09:42 INFO - (blobuploader) - INFO - Done attempting. 21:09:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:09:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:09:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:09:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:09:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:09:42 INFO - (blobuploader) - INFO - Done attempting. 21:09:42 INFO - (blobuploader) - INFO - Iteration through files over. 21:09:42 INFO - Return code: 0 21:09:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:09:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:09:42 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/20d82b367048a75eb5a50a469f3d1315e9fa2afc530a96b78494f8238b27e779784301915badf2ebe8fef08a631e0a402c3df854e2bd2272c3e2496aa8ddad4a", "resource-usage.json": null, "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3dfdbfa45e136ab10cce722b0868a6905df66fce87718289ff43d602470a2f43506fe715e7cbdd76390f2818900cc519e6d41107adf1dfd387b0ca8d3fd8239e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3bf5416743009f8413bcf7e81c24ba8d9be0a2379f668ee40acb61084503b87c8668dd6f4c92d641b5acc9ea824bcfa2b91baeeeade3248307c6518670d684a4"} 21:09:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:09:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:09:42 INFO - Contents: 21:09:42 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/20d82b367048a75eb5a50a469f3d1315e9fa2afc530a96b78494f8238b27e779784301915badf2ebe8fef08a631e0a402c3df854e2bd2272c3e2496aa8ddad4a", "resource-usage.json": null, "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3dfdbfa45e136ab10cce722b0868a6905df66fce87718289ff43d602470a2f43506fe715e7cbdd76390f2818900cc519e6d41107adf1dfd387b0ca8d3fd8239e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3bf5416743009f8413bcf7e81c24ba8d9be0a2379f668ee40acb61084503b87c8668dd6f4c92d641b5acc9ea824bcfa2b91baeeeade3248307c6518670d684a4"} 21:09:42 INFO - Running post-run listener: copy_logs_to_upload_dir 21:09:42 INFO - Copying logs to upload dir... 21:09:42 INFO - mkdir: /builds/slave/test/build/upload/logs 21:09:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1322.063954 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 2 secs) (at 2017-04-24 21:09:42.368180) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-24 21:09:42.371618) ========= 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=923d835db2ba3686ebe126b700000192-1493089496.422526-2033550201 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/20d82b367048a75eb5a50a469f3d1315e9fa2afc530a96b78494f8238b27e779784301915badf2ebe8fef08a631e0a402c3df854e2bd2272c3e2496aa8ddad4a", "resource-usage.json": null, "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3dfdbfa45e136ab10cce722b0868a6905df66fce87718289ff43d602470a2f43506fe715e7cbdd76390f2818900cc519e6d41107adf1dfd387b0ca8d3fd8239e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3bf5416743009f8413bcf7e81c24ba8d9be0a2379f668ee40acb61084503b87c8668dd6f4c92d641b5acc9ea824bcfa2b91baeeeade3248307c6518670d684a4"} build_url:https://queue.taskcluster.net/v1/task/JqbWFgNnSc2wFIq8kjQJ2w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011416 build_url: 'https://queue.taskcluster.net/v1/task/JqbWFgNnSc2wFIq8kjQJ2w/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/20d82b367048a75eb5a50a469f3d1315e9fa2afc530a96b78494f8238b27e779784301915badf2ebe8fef08a631e0a402c3df854e2bd2272c3e2496aa8ddad4a", "resource-usage.json": null, "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3dfdbfa45e136ab10cce722b0868a6905df66fce87718289ff43d602470a2f43506fe715e7cbdd76390f2818900cc519e6d41107adf1dfd387b0ca8d3fd8239e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3bf5416743009f8413bcf7e81c24ba8d9be0a2379f668ee40acb61084503b87c8668dd6f4c92d641b5acc9ea824bcfa2b91baeeeade3248307c6518670d684a4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-24 21:09:42.396865) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 21:09:42.397259) ========= 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=923d835db2ba3686ebe126b700000192-1493089496.422526-2033550201 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004437 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 21:09:42.481573) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-24 21:09:42.481901) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-24 21:09:42.482230) ========= ========= Total master_lag: 0.17 =========