builder: pine_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-030 starttime: 1490320886.4 results: success (0) revision: 84ba19887b668b16c7d2e182f6d61524a2904b9e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-23 19:01:26.404317) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-23 19:01:26.404852) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-23 19:01:26.405173) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-23 19:01:26.420539) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 19:01:26.420924) ========= 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=3836458cccd887f2d2de3cf1000001de-1490320885.753994-1075068045 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-23 19:01:26-- 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% 19.3M=0.001s 2017-03-23 19:01:26 (19.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.141374 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 19:01:26.576784) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 19:01:26.577143) ========= 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=3836458cccd887f2d2de3cf1000001de-1490320885.753994-1075068045 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020096 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 19:01:26.627780) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-23 19:01:26.628159) ========= bash -c 'python archiver_client.py mozharness --repo projects/pine --rev 84ba19887b668b16c7d2e182f6d61524a2904b9e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo projects/pine --rev 84ba19887b668b16c7d2e182f6d61524a2904b9e --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=3836458cccd887f2d2de3cf1000001de-1490320885.753994-1075068045 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-23 19:01:26,878 truncating revision to first 12 chars 2017-03-23 19:01:26,878 Setting DEBUG logging. 2017-03-23 19:01:26,878 attempt 1/10 2017-03-23 19:01:26,878 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/pine/84ba19887b66?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-23 19:01:28,279 unpacking tar archive at: pine-84ba19887b66/testing/mozharness/ program finished with exit code 0 elapsedTime=1.711502 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-23 19:01:28.354048) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-23 19:01:28.354521) ========= script_repo_revision: 84ba19887b668b16c7d2e182f6d61524a2904b9e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-23 19:01:28.354960) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-23 19:01:28.355265) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-23 19:01:28.365877) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-03-23 19:01:28.366325) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Pine --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Pine in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Pine', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Pine'] 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=3836458cccd887f2d2de3cf1000001de-1490320885.753994-1075068045 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:01:28 INFO - MultiFileLogger online at 20170323 19:01:28 in /builds/slave/test 19:01:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Pine --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Pine 19:01:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:01:28 INFO - {'append_to_log': False, 19:01:28 INFO - 'base_work_dir': '/builds/slave/test', 19:01:28 INFO - 'blob_upload_branch': 'Pine', 19:01:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:01:28 INFO - 'branch': 'Pine', 19:01:28 INFO - 'buildbot_json_path': 'buildprops.json', 19:01:28 INFO - 'config_files': ('talos/linux_config.py',), 19:01:28 INFO - 'default_actions': ('clobber', 19:01:28 INFO - 'read-buildbot-config', 19:01:28 INFO - 'download-and-extract', 19:01:28 INFO - 'populate-webroot', 19:01:28 INFO - 'create-virtualenv', 19:01:28 INFO - 'install', 19:01:28 INFO - 'run-tests'), 19:01:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:01:28 INFO - 'download_minidump_stackwalk': True, 19:01:28 INFO - 'download_symbols': 'ondemand', 19:01:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:01:28 INFO - 'tooltool.py': '/tools/tooltool.py', 19:01:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:01:28 INFO - '/tools/misc-python/virtualenv.py')}, 19:01:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:01:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:01:28 INFO - 'gecko_profile': False, 19:01:28 INFO - 'gecko_profile_interval': 0, 19:01:28 INFO - 'installer_path': 'installer.exe', 19:01:28 INFO - 'log_level': 'info', 19:01:28 INFO - 'log_name': 'talos', 19:01:28 INFO - 'log_to_console': True, 19:01:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:01:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:01:28 INFO - 'opt_config_files': (), 19:01:28 INFO - 'pip_index': False, 19:01:28 INFO - 'suite': 'dromaeojs-e10s', 19:01:28 INFO - 'system_bits': '32', 19:01:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:01:28 INFO - 'title': 'talos-linux64-ix-030', 19:01:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:01:28 INFO - 'use_talos_json': True, 19:01:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:01:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:01:28 INFO - 'work_dir': 'build'} 19:01:28 INFO - [mozharness: 2017-03-24 02:01:28.722161Z] Running clobber step. 19:01:28 INFO - Running pre-action listener: _resource_record_pre_action 19:01:28 INFO - Running main action method: clobber 19:01:28 INFO - rmtree: /builds/slave/test/build 19:01:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:01:30 INFO - Running post-action listener: _resource_record_post_action 19:01:30 INFO - [mozharness: 2017-03-24 02:01:30.189514Z] Finished clobber step (success) 19:01:30 INFO - [mozharness: 2017-03-24 02:01:30.189622Z] Running read-buildbot-config step. 19:01:30 INFO - Running pre-action listener: _resource_record_pre_action 19:01:30 INFO - Running main action method: read_buildbot_config 19:01:30 INFO - Using buildbot properties: 19:01:30 INFO - { 19:01:30 INFO - "project": "", 19:01:30 INFO - "product": "firefox", 19:01:30 INFO - "who": "dmosedale@mozilla.com", 19:01:30 INFO - "installer_path": "public/build/target.tar.bz2", 19:01:30 INFO - "builddir": "pine_ubuntu64_hw_test-dromaeojs-e10s", 19:01:30 INFO - "repository": "https://hg.mozilla.org/projects/pine/", 19:01:30 INFO - "buildername": "Ubuntu HW 12.04 x64 pine talos dromaeojs-e10s", 19:01:30 INFO - "stage_platform": "linux64", 19:01:30 INFO - "basedir": "/builds/slave/test", 19:01:30 INFO - "buildnumber": 1, 19:01:30 INFO - "platform": "ubuntu64_hw", 19:01:30 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:01:30 INFO - "slavebuilddir": "test", 19:01:30 INFO - "taskId": "L4i2600PSqqoZKOODIbQ5g", 19:01:30 INFO - "branch": "pine", 19:01:30 INFO - "script_repo_revision": "default", 19:01:30 INFO - "revision": "84ba19887b668b16c7d2e182f6d61524a2904b9e", 19:01:30 INFO - "slavename": "talos-linux64-ix-030", 19:01:30 INFO - "repo_path": "projects/pine" 19:01:30 INFO - } 19:01:30 INFO - Finding installer, test and symbols from parent task. 19:01:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L4i2600PSqqoZKOODIbQ5g'}, attempt #1 19:01:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L4i2600PSqqoZKOODIbQ5g'}, attempt #1 19:01:31 INFO - Task dependencies: BB5OsR0cSquSGZobh5SR5g 19:01:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BB5OsR0cSquSGZobh5SR5g'}, attempt #1 19:01:31 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/BB5OsR0cSquSGZobh5SR5g/artifacts/public/build/target.tar.bz2 19:01:31 INFO - Set test_url: https://queue.taskcluster.net/v1/task/BB5OsR0cSquSGZobh5SR5g/artifacts/public/build/test_packages.json 19:01:31 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/BB5OsR0cSquSGZobh5SR5g/artifacts/public/build/target.crashreporter-symbols.zip 19:01:31 INFO - Running post-action listener: _resource_record_post_action 19:01:31 INFO - [mozharness: 2017-03-24 02:01:31.630114Z] Finished read-buildbot-config step (success) 19:01:31 INFO - [mozharness: 2017-03-24 02:01:31.630331Z] Running download-and-extract step. 19:01:31 INFO - Running pre-action listener: _resource_record_pre_action 19:01:31 INFO - Running main action method: download_and_extract 19:01:31 INFO - mkdir: /builds/slave/test/build/tests 19:01: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')]} 19:01:31 INFO - trying https://queue.taskcluster.net/v1/task/BB5OsR0cSquSGZobh5SR5g/artifacts/public/build/target.test_packages.json 19:01:31 INFO - Downloading https://queue.taskcluster.net/v1/task/BB5OsR0cSquSGZobh5SR5g/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 19:01:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BB5OsR0cSquSGZobh5SR5g/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 19:01:32 INFO - Downloaded 986 bytes. 19:01:32 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 19:01:32 INFO - Using the following test package requirements: 19:01:32 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 19:01:32 INFO - u'common': [u'target.common.tests.zip'], 19:01:32 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 19:01:32 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 19:01:32 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 19:01:32 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 19:01:32 INFO - u'mozbase': [u'target.common.tests.zip'], 19:01:32 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 19:01:32 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 19:01:32 INFO - u'web-platform': [u'target.common.tests.zip', 19:01:32 INFO - u'target.web-platform.tests.zip'], 19:01:32 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 19:01:32 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 19:01:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BB5OsR0cSquSGZobh5SR5g/artifacts/public/build/target.common.tests.zip 19:01:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BB5OsR0cSquSGZobh5SR5g/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:01:32 INFO - Fetch https://queue.taskcluster.net/v1/task/BB5OsR0cSquSGZobh5SR5g/artifacts/public/build/target.common.tests.zip into memory 19:01:33 INFO - Expected file size: 58125537 19:01:33 INFO - Obtained file size: 58125537 19:01:43 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 19:01:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BB5OsR0cSquSGZobh5SR5g/artifacts/public/build/target.common.tests.zip 19:01:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BB5OsR0cSquSGZobh5SR5g/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:01:43 INFO - Fetch https://queue.taskcluster.net/v1/task/BB5OsR0cSquSGZobh5SR5g/artifacts/public/build/target.common.tests.zip into memory 19:01:44 INFO - Expected file size: 58125537 19:01:44 INFO - Obtained file size: 58125537 19:01:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BB5OsR0cSquSGZobh5SR5g/artifacts/public/build/target.talos.tests.zip 19:01:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BB5OsR0cSquSGZobh5SR5g/artifacts/public/build/target.talos.tests.zip'}, attempt #1 19:01:55 INFO - Fetch https://queue.taskcluster.net/v1/task/BB5OsR0cSquSGZobh5SR5g/artifacts/public/build/target.talos.tests.zip into memory 19:01:55 INFO - Expected file size: 14404171 19:01:55 INFO - Obtained file size: 14404171 19:01:56 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')]} 19:01:56 INFO - trying https://queue.taskcluster.net/v1/task/BB5OsR0cSquSGZobh5SR5g/artifacts/public/build/target.tar.bz2 19:01:56 INFO - Downloading https://queue.taskcluster.net/v1/task/BB5OsR0cSquSGZobh5SR5g/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 19:01:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BB5OsR0cSquSGZobh5SR5g/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 19:01:57 INFO - Downloaded 62535148 bytes. 19:01:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BB5OsR0cSquSGZobh5SR5g/artifacts/public/build/target.tar.bz2 19:01:57 INFO - mkdir: /builds/slave/test/properties 19:01:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:01:57 INFO - Writing to file /builds/slave/test/properties/build_url 19:01:57 INFO - Contents: 19:01:57 INFO - build_url:https://queue.taskcluster.net/v1/task/BB5OsR0cSquSGZobh5SR5g/artifacts/public/build/target.tar.bz2 19:01:57 INFO - Running post-action listener: _resource_record_post_action 19:01:57 INFO - Running post-action listener: set_extra_try_arguments 19:01:57 INFO - [mozharness: 2017-03-24 02:01:57.221460Z] Finished download-and-extract step (success) 19:01:57 INFO - [mozharness: 2017-03-24 02:01:57.221577Z] Running populate-webroot step. 19:01:57 INFO - Running pre-action listener: _resource_record_pre_action 19:01:57 INFO - Running main action method: populate_webroot 19:01:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:01:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:01:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:01:57 INFO - '--tppagecycles', 19:01:57 INFO - '7'], 19:01:57 INFO - 'tests': ['tsvgm']}}, 19:01:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:01:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:01:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:01:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:01:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:01:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:01:57 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 19:01:57 INFO - 'talos_options': ['--disable-e10s'], 19:01:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:01:57 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:01:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:01:57 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 19:01:57 INFO - 'talos_options': ['--disable-e10s'], 19:01:57 INFO - 'tests': ['damp', 'tps']}, 19:01:57 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:01:57 INFO - 'tests': ['damp', 'tps']}, 19:01:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:01:57 INFO - 'tests': ['dromaeo_dom']}, 19:01:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:01:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:01:57 INFO - 'tests': ['basic_compositor_video']}, 19:01:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:01:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:01:57 INFO - 'tests': ['a11yr', 19:01:57 INFO - 'ts_paint', 19:01:57 INFO - 'tpaint', 19:01:57 INFO - 'sessionrestore', 19:01:57 INFO - 'sessionrestore_no_auto_restore', 19:01:57 INFO - 'tabpaint']}, 19:01:57 INFO - 'other-e10s': {'tests': ['a11yr', 19:01:57 INFO - 'ts_paint', 19:01:57 INFO - 'tpaint', 19:01:57 INFO - 'sessionrestore', 19:01:57 INFO - 'sessionrestore_no_auto_restore', 19:01:57 INFO - 'tabpaint']}, 19:01:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:01:57 INFO - 'ts_paint', 19:01:57 INFO - 'tpaint', 19:01:57 INFO - 'sessionrestore', 19:01:57 INFO - 'sessionrestore_no_auto_restore', 19:01:57 INFO - 'tabpaint']}, 19:01:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:01:57 INFO - 'ts_paint', 19:01:57 INFO - 'tpaint', 19:01:57 INFO - 'sessionrestore', 19:01:57 INFO - 'sessionrestore_no_auto_restore', 19:01:57 INFO - 'tabpaint']}, 19:01:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:01:57 INFO - 'tests': ['a11yr', 19:01:57 INFO - 'ts_paint', 19:01:57 INFO - 'tpaint', 19:01:57 INFO - 'sessionrestore', 19:01:57 INFO - 'sessionrestore_no_auto_restore', 19:01:57 INFO - 'tabpaint']}, 19:01:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:01:57 INFO - 'tests': ['a11yr', 19:01:57 INFO - 'ts_paint', 19:01:57 INFO - 'tpaint', 19:01:57 INFO - 'sessionrestore', 19:01:57 INFO - 'sessionrestore_no_auto_restore', 19:01:57 INFO - 'tabpaint']}, 19:01:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:01:57 INFO - 'tests': ['tsvgx', 19:01:57 INFO - 'tsvgr_opacity', 19:01:57 INFO - 'tart', 19:01:57 INFO - 'tscrollx', 19:01:57 INFO - 'cart', 19:01:57 INFO - 'tsvg_static']}, 19:01:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:01:57 INFO - 'tsvgr_opacity', 19:01:57 INFO - 'tart', 19:01:57 INFO - 'tscrollx', 19:01:57 INFO - 'cart', 19:01:57 INFO - 'tsvg_static']}, 19:01:57 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 19:01:57 INFO - 'talos_options': ['--disable-e10s'], 19:01:57 INFO - 'tests': ['tp5o']}, 19:01:57 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:01:57 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 19:01:57 INFO - 'talos_options': ['--disable-e10s', 19:01:57 INFO - '--xperf_path', 19:01:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:01:57 INFO - 'tests': ['tp5n']}, 19:01:57 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:01:57 INFO - 'talos_options': ['--xperf_path', 19:01:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:01:57 INFO - 'tests': ['tp5n']}}, 19:01:57 INFO - 'talos.zip': {'path': '', 19:01:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:01:57 INFO - Running post-action listener: _resource_record_post_action 19:01:57 INFO - [mozharness: 2017-03-24 02:01:57.234611Z] Finished populate-webroot step (success) 19:01:57 INFO - [mozharness: 2017-03-24 02:01:57.234701Z] Running create-virtualenv step. 19:01:57 INFO - Running pre-action listener: _resource_record_pre_action 19:01:57 INFO - Running main action method: create_virtualenv 19:01:57 INFO - Creating virtualenv /builds/slave/test/build/venv 19:01:57 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 19:01:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:01:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:01:57 INFO - Using real prefix '/usr' 19:01:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:01:57 INFO - Installing distribute.............................................................................................................................................................................................done. 19:01:59 INFO - Installing pip.................done. 19:01:59 INFO - Return code: 0 19:01:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:01:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:02:00 INFO - Reading from file tmpfile_stdout 19:02:00 INFO - Output received: 19:02:00 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) 19:02:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:02:00 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')]} 19:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:00 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')]} 19:02:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:00 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 0x25d51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2872b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2870290>, '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 0x2870b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2871040>, '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': '3836458cccd887f2d2de3cf1000001de-1490320885.753994-1075068045', '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 19:02:00 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 19:02:00 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 19:02:00 INFO - Using env: {'DISPLAY': ':0', 19:02:00 INFO - 'HOME': '/home/cltbld', 19:02:00 INFO - 'LANG': 'en_US.UTF-8', 19:02:00 INFO - 'LANGUAGE': 'en_US:en', 19:02:00 INFO - 'LOGNAME': 'cltbld', 19:02:00 INFO - 'MAIL': '/var/mail/cltbld', 19:02:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:00 INFO - 'MOZ_NO_REMOTE': '1', 19:02:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:02:00 INFO - 'NO_EM_RESTART': '1', 19:02:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:02:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:00 INFO - 'PWD': '/builds/slave/test', 19:02:00 INFO - 'SHELL': '/bin/bash', 19:02:00 INFO - 'SHLVL': '1', 19:02:00 INFO - 'TERM': 'linux', 19:02:00 INFO - 'TMOUT': '86400', 19:02:00 INFO - 'USER': 'cltbld', 19:02:00 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1490320885.753994-1075068045', 19:02:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:00 INFO - '_': '/tools/buildbot/bin/python'} 19:02:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:00 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 19:02:00 INFO - Cleaning up... 19:02:00 INFO - Return code: 0 19:02:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:02:00 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')]} 19:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:00 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')]} 19:02:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:00 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 0x25d51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2872b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2870290>, '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 0x2870b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2871040>, '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': '3836458cccd887f2d2de3cf1000001de-1490320885.753994-1075068045', '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 19:02:00 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 19:02:00 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 19:02:00 INFO - Using env: {'DISPLAY': ':0', 19:02:00 INFO - 'HOME': '/home/cltbld', 19:02:00 INFO - 'LANG': 'en_US.UTF-8', 19:02:00 INFO - 'LANGUAGE': 'en_US:en', 19:02:00 INFO - 'LOGNAME': 'cltbld', 19:02:00 INFO - 'MAIL': '/var/mail/cltbld', 19:02:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:00 INFO - 'MOZ_NO_REMOTE': '1', 19:02:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:02:00 INFO - 'NO_EM_RESTART': '1', 19:02:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:02:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:00 INFO - 'PWD': '/builds/slave/test', 19:02:00 INFO - 'SHELL': '/bin/bash', 19:02:00 INFO - 'SHLVL': '1', 19:02:00 INFO - 'TERM': 'linux', 19:02:00 INFO - 'TMOUT': '86400', 19:02:00 INFO - 'USER': 'cltbld', 19:02:00 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1490320885.753994-1075068045', 19:02:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:00 INFO - '_': '/tools/buildbot/bin/python'} 19:02:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:00 INFO - Downloading/unpacking psutil>=3.1.1 19:02:00 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 19:02:00 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 19:02:00 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 19:02:00 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 19:02:00 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 19:02:00 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 19:02:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:02:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:02:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:02:02 INFO - Installing collected packages: psutil 19:02:02 INFO - Running setup.py install for psutil 19:02:02 INFO - building 'psutil._psutil_linux' extension 19:02:02 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 19:02:02 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 19:02:02 INFO - building 'psutil._psutil_posix' extension 19:02:02 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 19:02:02 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 19:02:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:02:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:02:03 INFO - Successfully installed psutil 19:02:03 INFO - Cleaning up... 19:02:03 INFO - Return code: 0 19:02:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:02:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:02:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:02:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:03 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 0x25d51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2872b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2870290>, '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 0x2870b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2871040>, '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': '3836458cccd887f2d2de3cf1000001de-1490320885.753994-1075068045', '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 19:02:03 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 19:02:03 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 19:02:03 INFO - Using env: {'DISPLAY': ':0', 19:02:03 INFO - 'HOME': '/home/cltbld', 19:02:03 INFO - 'LANG': 'en_US.UTF-8', 19:02:03 INFO - 'LANGUAGE': 'en_US:en', 19:02:03 INFO - 'LOGNAME': 'cltbld', 19:02:03 INFO - 'MAIL': '/var/mail/cltbld', 19:02:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:03 INFO - 'MOZ_NO_REMOTE': '1', 19:02:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:02:03 INFO - 'NO_EM_RESTART': '1', 19:02:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:02:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:03 INFO - 'PWD': '/builds/slave/test', 19:02:03 INFO - 'SHELL': '/bin/bash', 19:02:03 INFO - 'SHLVL': '1', 19:02:03 INFO - 'TERM': 'linux', 19:02:03 INFO - 'TMOUT': '86400', 19:02:03 INFO - 'USER': 'cltbld', 19:02:03 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1490320885.753994-1075068045', 19:02:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:03 INFO - '_': '/tools/buildbot/bin/python'} 19:02:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:02:03 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 19:02:03 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 19:02:03 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 19:02:03 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 19:02:03 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 19:02:03 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 19:02:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:02:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:02:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:02:05 INFO - Installing collected packages: mozsystemmonitor 19:02:05 INFO - Running setup.py install for mozsystemmonitor 19:02:05 INFO - Successfully installed mozsystemmonitor 19:02:05 INFO - Cleaning up... 19:02:05 INFO - Return code: 0 19:02:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:02:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:02:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:02:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:05 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 0x25d51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2872b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2870290>, '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 0x2870b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2871040>, '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': '3836458cccd887f2d2de3cf1000001de-1490320885.753994-1075068045', '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 19:02:05 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 19:02:05 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 19:02:05 INFO - Using env: {'DISPLAY': ':0', 19:02:05 INFO - 'HOME': '/home/cltbld', 19:02:05 INFO - 'LANG': 'en_US.UTF-8', 19:02:05 INFO - 'LANGUAGE': 'en_US:en', 19:02:05 INFO - 'LOGNAME': 'cltbld', 19:02:05 INFO - 'MAIL': '/var/mail/cltbld', 19:02:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:05 INFO - 'MOZ_NO_REMOTE': '1', 19:02:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:02:05 INFO - 'NO_EM_RESTART': '1', 19:02:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:02:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:05 INFO - 'PWD': '/builds/slave/test', 19:02:05 INFO - 'SHELL': '/bin/bash', 19:02:05 INFO - 'SHLVL': '1', 19:02:05 INFO - 'TERM': 'linux', 19:02:05 INFO - 'TMOUT': '86400', 19:02:05 INFO - 'USER': 'cltbld', 19:02:05 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1490320885.753994-1075068045', 19:02:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:05 INFO - '_': '/tools/buildbot/bin/python'} 19:02:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:05 INFO - Downloading/unpacking jsonschema==2.5.1 19:02:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:02:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:02:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:02:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:02:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:02:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:02:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:08 INFO - Downloading functools32-3.2.3-2.tar.gz 19:02:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:02:08 INFO - warning: no files found matching '*.txt' 19:02:08 INFO - no previously-included directories found matching 'build' 19:02:08 INFO - no previously-included directories found matching 'dist' 19:02:08 INFO - no previously-included directories found matching '.git*' 19:02:08 INFO - Installing collected packages: jsonschema, functools32 19:02:08 INFO - Running setup.py install for functools32 19:02:08 INFO - warning: no files found matching '*.txt' 19:02:08 INFO - no previously-included directories found matching 'build' 19:02:08 INFO - no previously-included directories found matching 'dist' 19:02:08 INFO - no previously-included directories found matching '.git*' 19:02:08 INFO - Successfully installed jsonschema functools32 19:02:08 INFO - Cleaning up... 19:02:08 INFO - Return code: 0 19:02:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:02:08 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')]} 19:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:08 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')]} 19:02:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:08 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 0x25d51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2872b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2870290>, '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 0x2870b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2871040>, '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': '3836458cccd887f2d2de3cf1000001de-1490320885.753994-1075068045', '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 19:02:08 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 19:02:08 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 19:02:08 INFO - Using env: {'DISPLAY': ':0', 19:02:08 INFO - 'HOME': '/home/cltbld', 19:02:08 INFO - 'LANG': 'en_US.UTF-8', 19:02:08 INFO - 'LANGUAGE': 'en_US:en', 19:02:08 INFO - 'LOGNAME': 'cltbld', 19:02:08 INFO - 'MAIL': '/var/mail/cltbld', 19:02:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:08 INFO - 'MOZ_NO_REMOTE': '1', 19:02:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:02:08 INFO - 'NO_EM_RESTART': '1', 19:02:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:02:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:08 INFO - 'PWD': '/builds/slave/test', 19:02:08 INFO - 'SHELL': '/bin/bash', 19:02:08 INFO - 'SHLVL': '1', 19:02:08 INFO - 'TERM': 'linux', 19:02:08 INFO - 'TMOUT': '86400', 19:02:08 INFO - 'USER': 'cltbld', 19:02:08 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1490320885.753994-1075068045', 19:02:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:08 INFO - '_': '/tools/buildbot/bin/python'} 19:02:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:02:08 INFO - Cleaning up... 19:02:08 INFO - Return code: 0 19:02:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:02:08 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')]} 19:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:08 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')]} 19:02:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:08 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 0x25d51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2872b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2870290>, '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 0x2870b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2871040>, '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': '3836458cccd887f2d2de3cf1000001de-1490320885.753994-1075068045', '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 19:02:08 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 19:02:08 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 19:02:08 INFO - Using env: {'DISPLAY': ':0', 19:02:08 INFO - 'HOME': '/home/cltbld', 19:02:08 INFO - 'LANG': 'en_US.UTF-8', 19:02:08 INFO - 'LANGUAGE': 'en_US:en', 19:02:08 INFO - 'LOGNAME': 'cltbld', 19:02:08 INFO - 'MAIL': '/var/mail/cltbld', 19:02:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:08 INFO - 'MOZ_NO_REMOTE': '1', 19:02:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:02:08 INFO - 'NO_EM_RESTART': '1', 19:02:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:02:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:08 INFO - 'PWD': '/builds/slave/test', 19:02:08 INFO - 'SHELL': '/bin/bash', 19:02:08 INFO - 'SHLVL': '1', 19:02:08 INFO - 'TERM': 'linux', 19:02:08 INFO - 'TMOUT': '86400', 19:02:08 INFO - 'USER': 'cltbld', 19:02:08 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1490320885.753994-1075068045', 19:02:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:08 INFO - '_': '/tools/buildbot/bin/python'} 19:02:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:08 INFO - Downloading/unpacking blobuploader==1.2.4 19:02:08 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 19:02:08 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 19:02:08 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 19:02:08 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 19:02:08 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 19:02:08 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 19:02:11 INFO - Downloading blobuploader-1.2.4.tar.gz 19:02:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:02:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:02:11 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 19:02:11 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 19:02:11 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 19:02:11 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 19:02:11 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 19:02:11 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 19:02:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:02:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:02:11 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 19:02:11 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 19:02:11 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 19:02:11 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 19:02:11 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 19:02:11 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 19:02:11 INFO - Downloading docopt-0.6.1.tar.gz 19:02:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:02:11 INFO - Installing collected packages: blobuploader, requests, docopt 19:02:11 INFO - Running setup.py install for blobuploader 19:02:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:02:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:02:11 INFO - Running setup.py install for requests 19:02:12 INFO - Running setup.py install for docopt 19:02:12 INFO - Successfully installed blobuploader requests docopt 19:02:12 INFO - Cleaning up... 19:02:12 INFO - Return code: 0 19:02:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:02: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')]} 19:02:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02: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')]} 19:02:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:12 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 0x25d51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2872b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2870290>, '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 0x2870b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2871040>, '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': '3836458cccd887f2d2de3cf1000001de-1490320885.753994-1075068045', '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 19:02:12 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 19:02:12 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 19:02:12 INFO - Using env: {'DISPLAY': ':0', 19:02:12 INFO - 'HOME': '/home/cltbld', 19:02:12 INFO - 'LANG': 'en_US.UTF-8', 19:02:12 INFO - 'LANGUAGE': 'en_US:en', 19:02:12 INFO - 'LOGNAME': 'cltbld', 19:02:12 INFO - 'MAIL': '/var/mail/cltbld', 19:02:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:12 INFO - 'MOZ_NO_REMOTE': '1', 19:02:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:02:12 INFO - 'NO_EM_RESTART': '1', 19:02:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:02:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:12 INFO - 'PWD': '/builds/slave/test', 19:02:12 INFO - 'SHELL': '/bin/bash', 19:02:12 INFO - 'SHLVL': '1', 19:02:12 INFO - 'TERM': 'linux', 19:02:12 INFO - 'TMOUT': '86400', 19:02:12 INFO - 'USER': 'cltbld', 19:02:12 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1490320885.753994-1075068045', 19:02:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:12 INFO - '_': '/tools/buildbot/bin/python'} 19:02:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:02:12 INFO - Running setup.py (path:/tmp/pip-yAo6Bt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:02:12 INFO - Running setup.py (path:/tmp/pip-Nemi1A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:02:12 INFO - Running setup.py (path:/tmp/pip-aYd0Nd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:02:12 INFO - Running setup.py (path:/tmp/pip-l2KuqN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:02:12 INFO - Running setup.py (path:/tmp/pip-jiS9FW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:02:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:02:13 INFO - Running setup.py (path:/tmp/pip-9DC1Bt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:02:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:02:13 INFO - Running setup.py (path:/tmp/pip-DO9AUV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:02:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:02:13 INFO - Running setup.py (path:/tmp/pip-fPQVKu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:02:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:02:13 INFO - Running setup.py (path:/tmp/pip-rFyTMI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:02:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:02:13 INFO - Running setup.py (path:/tmp/pip-cjLrCc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:02:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:02:13 INFO - Running setup.py (path:/tmp/pip-kScXxS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:02:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:02:13 INFO - Running setup.py (path:/tmp/pip-rwqSv6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:02:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:02:13 INFO - Running setup.py (path:/tmp/pip-2nNokP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:02:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:02:13 INFO - Running setup.py (path:/tmp/pip-iys8y0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:02:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:02:13 INFO - Running setup.py (path:/tmp/pip-vuraBj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:02:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:02:13 INFO - Running setup.py (path:/tmp/pip-KTfd3H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:02:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:02:13 INFO - Running setup.py (path:/tmp/pip-iFHANN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:02:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:02:13 INFO - Running setup.py install for manifestparser 19:02:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:02:13 INFO - Running setup.py install for mozcrash 19:02:14 INFO - Running setup.py install for mozdebug 19:02:14 INFO - Running setup.py install for mozdevice 19:02:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:02:14 INFO - Running setup.py install for mozfile 19:02:14 INFO - Running setup.py install for mozhttpd 19:02:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:02:14 INFO - Running setup.py install for mozinfo 19:02:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:02:14 INFO - Running setup.py install for mozInstall 19:02:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:02:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:02:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:02:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:02:14 INFO - Running setup.py install for mozleak 19:02:14 INFO - Running setup.py install for mozlog 19:02:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:02:14 INFO - Running setup.py install for moznetwork 19:02:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:02:15 INFO - Running setup.py install for mozprocess 19:02:15 INFO - Running setup.py install for mozprofile 19:02:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:02:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:02:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:02:15 INFO - Running setup.py install for mozrunner 19:02:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:02:15 INFO - Running setup.py install for mozscreenshot 19:02:15 INFO - Running setup.py install for moztest 19:02:15 INFO - Running setup.py install for mozversion 19:02:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:02:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:02:15 INFO - Cleaning up... 19:02:15 INFO - Return code: 0 19:02:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:02: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')]} 19:02:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02: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')]} 19:02:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:15 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 0x25d51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2872b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2870290>, '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 0x2870b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2871040>, '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': '3836458cccd887f2d2de3cf1000001de-1490320885.753994-1075068045', '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 19:02:15 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 19:02:15 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 19:02:15 INFO - Using env: {'DISPLAY': ':0', 19:02:15 INFO - 'HOME': '/home/cltbld', 19:02:15 INFO - 'LANG': 'en_US.UTF-8', 19:02:15 INFO - 'LANGUAGE': 'en_US:en', 19:02:15 INFO - 'LOGNAME': 'cltbld', 19:02:15 INFO - 'MAIL': '/var/mail/cltbld', 19:02:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:15 INFO - 'MOZ_NO_REMOTE': '1', 19:02:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:02:15 INFO - 'NO_EM_RESTART': '1', 19:02:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:02:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:15 INFO - 'PWD': '/builds/slave/test', 19:02:15 INFO - 'SHELL': '/bin/bash', 19:02:15 INFO - 'SHLVL': '1', 19:02:15 INFO - 'TERM': 'linux', 19:02:15 INFO - 'TMOUT': '86400', 19:02:15 INFO - 'USER': 'cltbld', 19:02:15 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1490320885.753994-1075068045', 19:02:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:15 INFO - '_': '/tools/buildbot/bin/python'} 19:02:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:02:15 INFO - Running setup.py (path:/tmp/pip-z2MjXr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:02:16 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)) 19:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:02:16 INFO - Running setup.py (path:/tmp/pip-yL0FBE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:02:16 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)) 19:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:02:16 INFO - Running setup.py (path:/tmp/pip-QXIuqt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:02:16 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)) 19:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:02:16 INFO - Running setup.py (path:/tmp/pip-nsOInp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:02:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:02:16 INFO - Running setup.py (path:/tmp/pip-Qm9Jah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:02:16 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)) 19:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:02:16 INFO - Running setup.py (path:/tmp/pip-VHbPVc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:02:16 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)) 19:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:02:16 INFO - Running setup.py (path:/tmp/pip-wOGrH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:02:16 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)) 19:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:02:16 INFO - Running setup.py (path:/tmp/pip-TWZzfs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:02:16 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)) 19:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:02:16 INFO - Running setup.py (path:/tmp/pip-fuiR2W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:02:16 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)) 19:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:02:16 INFO - Running setup.py (path:/tmp/pip-_Gsa2_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:02:16 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)) 19:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:02:16 INFO - Running setup.py (path:/tmp/pip-uCI6fa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:02:16 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)) 19:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:02:16 INFO - Running setup.py (path:/tmp/pip-tABjQm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:02:16 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)) 19:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:02:16 INFO - Running setup.py (path:/tmp/pip-eHIgev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:02:16 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)) 19:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:02:16 INFO - Running setup.py (path:/tmp/pip-ERtDsG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:02:16 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)) 19:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:02:16 INFO - Running setup.py (path:/tmp/pip-RnTJ06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:02:17 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)) 19:02:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:02:17 INFO - Running setup.py (path:/tmp/pip-uJ3Glu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:02:17 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)) 19:02:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:02:17 INFO - Running setup.py (path:/tmp/pip-dy7vYL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:02:17 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)) 19:02:17 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)) 19:02:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:02:17 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)) 19:02:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:02:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:02:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:02:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:02:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:02:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:19 INFO - Downloading blessings-1.6.tar.gz 19:02:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:02:19 INFO - Installing collected packages: blessings 19:02:19 INFO - Running setup.py install for blessings 19:02:19 INFO - Successfully installed blessings 19:02:19 INFO - Cleaning up... 19:02:19 INFO - Return code: 0 19:02:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:02:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:02:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:02:19 INFO - Reading from file tmpfile_stdout 19:02:19 INFO - Current package versions: 19:02:19 INFO - argparse == 1.2.1 19:02:19 INFO - blessings == 1.6 19:02:19 INFO - blobuploader == 1.2.4 19:02:19 INFO - docopt == 0.6.1 19:02:19 INFO - functools32 == 3.2.3-2 19:02:19 INFO - jsonschema == 2.5.1 19:02:19 INFO - manifestparser == 1.1 19:02:19 INFO - mozInstall == 1.12 19:02:19 INFO - mozcrash == 1.0 19:02:19 INFO - mozdebug == 0.1 19:02:19 INFO - mozdevice == 0.49 19:02:19 INFO - mozfile == 1.2 19:02:19 INFO - mozhttpd == 0.7 19:02:19 INFO - mozinfo == 0.9 19:02:19 INFO - mozleak == 0.1 19:02:19 INFO - mozlog == 3.4 19:02:19 INFO - moznetwork == 0.27 19:02:19 INFO - mozprocess == 0.25 19:02:19 INFO - mozprofile == 0.28 19:02:19 INFO - mozrunner == 6.13 19:02:19 INFO - mozscreenshot == 0.1 19:02:19 INFO - mozsystemmonitor == 0.3 19:02:19 INFO - moztest == 0.8 19:02:19 INFO - mozversion == 1.4 19:02:19 INFO - psutil == 3.1.1 19:02:19 INFO - requests == 1.2.3 19:02:19 INFO - wsgiref == 0.1.2 19:02:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:02:19 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')]} 19:02:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:19 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')]} 19:02:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:19 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 0x25d51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2872b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2870290>, '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 0x2870b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2871040>, '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': '3836458cccd887f2d2de3cf1000001de-1490320885.753994-1075068045', '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 19:02:19 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 19:02:19 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 19:02:19 INFO - Using env: {'DISPLAY': ':0', 19:02:19 INFO - 'HOME': '/home/cltbld', 19:02:19 INFO - 'LANG': 'en_US.UTF-8', 19:02:19 INFO - 'LANGUAGE': 'en_US:en', 19:02:19 INFO - 'LOGNAME': 'cltbld', 19:02:19 INFO - 'MAIL': '/var/mail/cltbld', 19:02:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:19 INFO - 'MOZ_NO_REMOTE': '1', 19:02:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:02:19 INFO - 'NO_EM_RESTART': '1', 19:02:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:02:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:19 INFO - 'PWD': '/builds/slave/test', 19:02:19 INFO - 'SHELL': '/bin/bash', 19:02:19 INFO - 'SHLVL': '1', 19:02:19 INFO - 'TERM': 'linux', 19:02:19 INFO - 'TMOUT': '86400', 19:02:19 INFO - 'USER': 'cltbld', 19:02:19 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1490320885.753994-1075068045', 19:02:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:19 INFO - '_': '/tools/buildbot/bin/python'} 19:02:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:19 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)) 19:02:19 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)) 19:02:19 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)) 19:02:19 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)) 19:02:19 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)) 19:02:19 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)) 19:02:19 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)) 19:02:19 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)) 19:02:19 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)) 19:02:19 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)) 19:02:19 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)) 19:02:19 INFO - Cleaning up... 19:02:19 INFO - Return code: 0 19:02:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:02:19 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')]} 19:02:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:19 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')]} 19:02:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:19 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 0x25d51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2872b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2870290>, '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 0x2870b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2871040>, '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': '3836458cccd887f2d2de3cf1000001de-1490320885.753994-1075068045', '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 19:02:19 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 19:02:19 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 19:02:19 INFO - Using env: {'DISPLAY': ':0', 19:02:19 INFO - 'HOME': '/home/cltbld', 19:02:19 INFO - 'LANG': 'en_US.UTF-8', 19:02:19 INFO - 'LANGUAGE': 'en_US:en', 19:02:19 INFO - 'LOGNAME': 'cltbld', 19:02:19 INFO - 'MAIL': '/var/mail/cltbld', 19:02:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:19 INFO - 'MOZ_NO_REMOTE': '1', 19:02:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:02:19 INFO - 'NO_EM_RESTART': '1', 19:02:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:02:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:19 INFO - 'PWD': '/builds/slave/test', 19:02:19 INFO - 'SHELL': '/bin/bash', 19:02:19 INFO - 'SHLVL': '1', 19:02:19 INFO - 'TERM': 'linux', 19:02:19 INFO - 'TMOUT': '86400', 19:02:19 INFO - 'USER': 'cltbld', 19:02:19 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1490320885.753994-1075068045', 19:02:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:19 INFO - '_': '/tools/buildbot/bin/python'} 19:02:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:02:20 INFO - Cleaning up... 19:02:20 INFO - Return code: 0 19:02:20 INFO - Running post-action listener: _resource_record_post_action 19:02:20 INFO - Running post-action listener: _start_resource_monitoring 19:02:20 INFO - Starting resource monitoring. 19:02:20 INFO - [mozharness: 2017-03-24 02:02:20.181215Z] Finished create-virtualenv step (success) 19:02:20 INFO - [mozharness: 2017-03-24 02:02:20.181783Z] Running install step. 19:02:20 INFO - Running pre-action listener: _resource_record_pre_action 19:02:20 INFO - Running main action method: install 19:02:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:02:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:02:20 INFO - Reading from file tmpfile_stdout 19:02:20 INFO - Detecting whether we're running mozinstall >=1.0... 19:02:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:02:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:02:20 INFO - Reading from file tmpfile_stdout 19:02:20 INFO - Output received: 19:02:20 INFO - Usage: mozinstall [options] installer 19:02:20 INFO - Options: 19:02:20 INFO - -h, --help show this help message and exit 19:02:20 INFO - -d DEST, --destination=DEST 19:02:20 INFO - Directory to install application into. [default: 19:02:20 INFO - "/builds/slave/test"] 19:02:20 INFO - --app=APP Application being installed. [default: firefox] 19:02:20 INFO - mkdir: /builds/slave/test/build/application 19:02:20 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'] 19:02:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 19:02:36 INFO - Reading from file tmpfile_stdout 19:02:36 INFO - Output received: 19:02:36 INFO - /builds/slave/test/build/application/firefox/firefox 19:02:36 INFO - Running post-action listener: _resource_record_post_action 19:02:36 INFO - [mozharness: 2017-03-24 02:02:36.106063Z] Finished install step (success) 19:02:36 INFO - [mozharness: 2017-03-24 02:02:36.106334Z] Running run-tests step. 19:02:36 INFO - Running pre-action listener: _resource_record_pre_action 19:02:36 INFO - Running main action method: run_tests 19:02:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:02:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:02:36 INFO - Python 2.7.3 19:02:36 INFO - Return code: 0 19:02:36 INFO - grabbing minidump binary from tooltool 19:02:36 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')]} 19:02:36 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 0x2870290>, '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 0x2870b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2871040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:02:36 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 19:02:36 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 19:02:36 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 19:02:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:02:36 INFO - Return code: 0 19:02:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:02:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:02:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:02:36 INFO - ENV: RUST_BACKTRACE is now 1 19:02:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:02:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:02:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Pine', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BB5OsR0cSquSGZobh5SR5g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 19:02:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Pine --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BB5OsR0cSquSGZobh5SR5g/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-030 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 19:02:36 INFO - Using env: {'DISPLAY': ':0', 19:02:36 INFO - 'HOME': '/home/cltbld', 19:02:36 INFO - 'LANG': 'en_US.UTF-8', 19:02:36 INFO - 'LANGUAGE': 'en_US:en', 19:02:36 INFO - 'LOGNAME': 'cltbld', 19:02:36 INFO - 'MAIL': '/var/mail/cltbld', 19:02:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:02:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:02:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:36 INFO - 'MOZ_NO_REMOTE': '1', 19:02:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:02:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:02:36 INFO - 'NO_EM_RESTART': '1', 19:02:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:02:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:36 INFO - 'PWD': '/builds/slave/test', 19:02:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:02:36 INFO - 'RUST_BACKTRACE': '1', 19:02:36 INFO - 'SHELL': '/bin/bash', 19:02:36 INFO - 'SHLVL': '1', 19:02:36 INFO - 'TERM': 'linux', 19:02:36 INFO - 'TMOUT': '86400', 19:02:36 INFO - 'USER': 'cltbld', 19:02:36 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1490320885.753994-1075068045', 19:02:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:36 INFO - '_': '/tools/buildbot/bin/python'} 19:02:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Pine', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BB5OsR0cSquSGZobh5SR5g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 19:02:36 INFO - mozversion application_buildid: 20170323163151 19:02:36 INFO - mozversion application_changeset: 84ba19887b668b16c7d2e182f6d61524a2904b9e 19:02:36 INFO - mozversion application_display_name: Nightly 19:02:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:02:36 INFO - mozversion application_name: Firefox 19:02:36 INFO - mozversion application_remotingname: firefox 19:02:36 INFO - mozversion application_repository: https://hg.mozilla.org/projects/pine 19:02:36 INFO - mozversion application_vendor: Mozilla 19:02:36 INFO - mozversion application_version: 55.0a1 19:02:36 INFO - mozversion platform_buildid: 20170323163151 19:02:36 INFO - mozversion platform_changeset: 84ba19887b668b16c7d2e182f6d61524a2904b9e 19:02:36 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/pine 19:02:36 INFO - mozversion platform_version: 55.0a1 19:02:36 INFO - using testdate: 1490320956 19:02:36 INFO - actual date: 1490320956 19:02:36 INFO - starting webserver on 'localhost:52760' 19:02:36 INFO - SUITE-START | Running 2 tests 19:02:36 INFO - TEST-START | dromaeo_css 19:02:36 INFO - operating with platform_type : linux_ 19:02:36 INFO - Initialising browser for dromaeo_css test... 19:02:36 INFO - TEST-INFO | started process 9971 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuFYDEQ/profile http://localhost:52760/getInfo.html) 19:02:37 INFO - PID 9971 | 19:02:37 INFO - PID 9971 | { 19:02:37 INFO - PID 9971 | "TopSites": { 19:02:37 INFO - PID 9971 | "rows": [ 19:02:37 INFO - PID 9971 | { 19:02:37 INFO - PID 9971 | "title": "Facebook", 19:02:37 INFO - PID 9971 | "url": "https://www.facebook.com/" 19:02:37 INFO - PID 9971 | }, 19:02:37 INFO - PID 9971 | { 19:02:37 INFO - PID 9971 | "title": "YouTube", 19:02:37 INFO - PID 9971 | "url": "https://www.youtube.com/" 19:02:37 INFO - PID 9971 | }, 19:02:37 INFO - PID 9971 | { 19:02:37 INFO - PID 9971 | "title": "Amazon", 19:02:37 INFO - PID 9971 | "url": "http://www.amazon.com/" 19:02:37 INFO - PID 9971 | }, 19:02:37 INFO - PID 9971 | { 19:02:37 INFO - PID 9971 | "title": "Yahoo", 19:02:37 INFO - PID 9971 | "url": "https://www.yahoo.com/" 19:02:37 INFO - PID 9971 | }, 19:02:37 INFO - PID 9971 | { 19:02:37 INFO - PID 9971 | "title": "eBay", 19:02:37 INFO - PID 9971 | "url": "http://www.ebay.com" 19:02:37 INFO - PID 9971 | }, 19:02:37 INFO - PID 9971 | { 19:02:37 INFO - PID 9971 | "title": "Twitter", 19:02:37 INFO - PID 9971 | "url": "https://twitter.com/" 19:02:37 INFO - PID 9971 | } 19:02:37 INFO - PID 9971 | ] 19:02:37 INFO - PID 9971 | } 19:02:37 INFO - PID 9971 | } 19:02:41 INFO - PID 9971 | __metrics Screen width/height:1600/1200 19:02:41 INFO - PID 9971 | colorDepth:24 19:02:41 INFO - PID 9971 | Browser inner width/height: 1024/697 19:02:41 INFO - PID 9971 | __metrics 19:02:42 ERROR - PID 9971 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3388: TypeError: this.tabs is undefined 19:02:43 INFO - TEST-INFO | 9971: exit 0 19:02:43 INFO - Browser initialized. 19:02:43 INFO - Running cycle 1/1 for dromaeo_css test... 19:02:43 INFO - TEST-INFO | started process 10102 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuFYDEQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:02:43 INFO - PID 10102 | 19:02:43 INFO - PID 10102 | { 19:02:43 INFO - PID 10102 | "TopSites": { 19:02:43 INFO - PID 10102 | "rows": [ 19:02:43 INFO - PID 10102 | { 19:02:43 INFO - PID 10102 | "title": "Facebook", 19:02:43 INFO - PID 10102 | "url": "https://www.facebook.com/" 19:02:43 INFO - PID 10102 | }, 19:02:43 INFO - PID 10102 | { 19:02:43 INFO - PID 10102 | "title": "YouTube", 19:02:43 INFO - PID 10102 | "url": "https://www.youtube.com/" 19:02:43 INFO - PID 10102 | }, 19:02:43 INFO - PID 10102 | { 19:02:43 INFO - PID 10102 | "title": "Amazon", 19:02:43 INFO - PID 10102 | "url": "http://www.amazon.com/" 19:02:43 INFO - PID 10102 | }, 19:02:43 INFO - PID 10102 | { 19:02:43 INFO - PID 10102 | "title": "Yahoo", 19:02:43 INFO - PID 10102 | "url": "https://www.yahoo.com/" 19:02:43 INFO - PID 10102 | }, 19:02:43 INFO - PID 10102 | { 19:02:43 INFO - PID 10102 | "title": "eBay", 19:02:43 INFO - PID 10102 | "url": "http://www.ebay.com" 19:02:43 INFO - PID 10102 | }, 19:02:43 INFO - PID 10102 | { 19:02:43 INFO - PID 10102 | "title": "Twitter", 19:02:43 INFO - PID 10102 | "url": "https://twitter.com/" 19:02:43 INFO - PID 10102 | } 19:02:43 INFO - PID 10102 | ] 19:02:43 INFO - PID 10102 | } 19:02:43 INFO - PID 10102 | } 19:02:55 INFO - PID 10102 | RSS: Main: 155942912 19:02:55 INFO - PID 10102 | 19:05:59 INFO - PID 10102 | Cycle 1(1): loaded http://localhost:52760/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52760/tests/dromaeo/cssquery-ext.html) 19:06:01 INFO - PID 10102 | RSS: Main: 165031936 19:06:01 INFO - PID 10102 | 19:07:43 INFO - PID 10102 | ************************* 19:07:43 INFO - PID 10102 | A coding exception was thrown and uncaught in a Task. 19:07:43 INFO - PID 10102 | 19:07:43 ERROR - PID 10102 | Full message: TypeError: NetworkError when attempting to fetch resource. 19:07:43 INFO - PID 10102 | Full stack: 19:07:43 INFO - PID 10102 | ************************* 19:09:04 INFO - PID 10102 | Cycle 1(1): loaded http://localhost:52760/tests/dromaeo/cssquery-ext.html (next: http://localhost:52760/tests/dromaeo/cssquery-jquery.html) 19:09:04 INFO - PID 10102 | RSS: Main: 162152448 19:09:04 INFO - PID 10102 | 19:12:06 INFO - PID 10102 | Cycle 1(1): loaded http://localhost:52760/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52760/tests/dromaeo/cssquery-mootools.html) 19:12:07 INFO - PID 10102 | RSS: Main: 171048960 19:12:07 INFO - PID 10102 | 19:15:09 INFO - PID 10102 | Cycle 1(1): loaded http://localhost:52760/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52760/tests/dromaeo/cssquery-prototype.html) 19:15:09 INFO - PID 10102 | RSS: Main: 161910784 19:15:09 INFO - PID 10102 | 19:18:12 INFO - PID 10102 | Cycle 1(1): loaded http://localhost:52760/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52760/tests/dromaeo/cssquery-yui.html) 19:18:13 INFO - PID 10102 | RSS: Main: 169103360 19:18:13 INFO - PID 10102 | 19:21:16 INFO - PID 10102 | Cycle 1(1): loaded http://localhost:52760/tests/dromaeo/cssquery-yui.html (next: http://localhost:52760/tests/dromaeo/cssquery-dojo.html) 19:21:16 INFO - PID 10102 | RSS: Main: 162938880 19:21:16 INFO - PID 10102 | 19:21:16 INFO - PID 10102 | __start_tp_report 19:21:16 INFO - PID 10102 | _x_x_mozilla_page_load 19:21:16 INFO - PID 10102 | _x_x_mozilla_page_load_details 19:21:16 INFO - PID 10102 | |i|pagename|runs| 19:21:16 INFO - PID 10102 | |0;dojo.html;2663.17441593106;2674.807819896939;2690.5157071727094;2699.7300269973007;2718.6193932849405;5037.992401519692;5070.13807652699;5087.4149472810595;5162.045021670984;5186.74066296685;5064.215046667772;5163.432022477525;5169.715665638389;5232.110541207994;5235.816746413876;4659.790309436084;4664.906701865961;4683.578477936985;4689.2966055091665;4714.080754252922;4728.243481043034;4756.7383793891495;4757.286407038937;4776.259679749644;4812.398450193726;4690.1557719610455;4694.225452800284;4699.553542413465;4721.197396442579;4726.5746082852365;4716.693414928019;4720.079584481027;4734.053189362141;4748.833790817339;4768.094062128184;4622.399088118556;4655.837045703418;4676.041411510632;4705.670603057787;4726.338312636233;4937;4938.851834444937;4991.575716064139;4991.725455099968;5144.099782538041;5426.75579598915;5428.321459817523;5429.837104886859;5431.701256430894;5433.592480563934;5447.264619276387;5480.972595137038;5490.780368785244;5492.231087647732;5494.395616482184;5031.245313203049;5095.796168153232;5096.668716533413;5101.20931255656;5106.514881086291;5591.776328946797;5597.720113994284;5599.216109744639;5601.215829783833;5601.747921343549;5324.627276090714;5444.428335024844;5477.04151773438;5516.834494965157;5532.031894418461;5570.97214513933;5592.888142237132;5601.60788744784;5603.971980140154;5641.26663533738;5536.086545719912;5553.111502159635;5553.4724201200825;5555.9721451531595;5566.304211973504;5354.170103633943;5415.5938304626525;5506;5543.113101903757;5611.8597035073635;4562.8631141065825;4576.130535198302;4594.977025114853;4605.332226827091;4609.377734005866;3944.546377166605;3949.940750888739;3983.3626619740703;3990.4812374391145;4003.3794761811964;4702.036082603058;4754.762261886961;4778.738999276965;4819.807207711722;4819.831305904277;5569.749361278752;5593.608447408724;5595.328560572757;5604.971975140098;5619.409961953936;4836.613070954315;4845.6608037437745;4855.223164293696;4856.247281671346;4892.926606100911;4797.136515427256;4840.636952228527;4965.950340496621;4966.751662416865;4981.601471882241;5080.288759573588;5081.136206844772;5082.847514574569;5083.389993200692;5087.109755792795;5367.570594352521;5405.675659460445;5412.594055445778;5418.566514678895;5429.511343979061;5214.608904332114;5233.215017747369;5237.528622424;5277.182036784305;5280.706226974416;5422.891542169214;5459.481349271813;5486.753096110605;5497.065498865282;5497.092979658311;5436.483534064258;5569.777208911761;5573.359063707726;5585.245991791056;5630.23991761107;5308.708021058879;5430.456954304538;5437.4018857926385;5476.534494568006;5482.80810171642;5411.78352865881;5448.427915069019;5465;5467.4532546745;5473.0969390050195;5327.493888080626;5339.439358867418;5397.325334333208;5400;5439.673619582838;5324.946750532445;5356.973215134055;5359.437259087896;5359.866003349947;5369.006733754268;5310;5338.57291416678;5355.196720491957;5373.919391209213;5384.6769193848495 19:21:16 INFO - PID 10102 | |1;ext.html;553.8551231598892;611.2084850119096;625.5402279324697;1162.895339419452;1190.7499425120725;32293;32819.17952051197;33059.173520661934;33125;33183.66816331836;30359.696403035963;30730.846345768296;30830;30876.38247235054;30884.84557577209;6800.659967001642;7140.714371425162;7290.161631412376;7294.197638259787;7301.817454563626;7406.7777966660815;7413.369863561604;7440.888386674204;7487.513311634753;7511.849763004737;7461.664225109856;7520.736774212904;7530.58581778002;7533.133689625708;7544.4718869679145;7408.703651853919;7489.363404110684;7512.361449276818;7638.083429988437;7668.041494813148;7344.192138864721;7394.112706475204;7395.149557800868;7402.259774022555;7405.444591655593;32936.3412731744;33270.50094248588;33274.168145796546;33416.49875251873;33462;2632.670916135483;2647.7749391301763;2663.2409763217584;2668.6397336359732;2686.2344231893817;23588.29235122932;23690.881545592336;24018.51962960731;24228.304018718696;24887.875560622262;2631.8289311194903;2653.6948250951195;2654.8539830309323;2655.322892662378;2682.088090049373;112687.43656281749;113435;154841;155199;155417;39334.213315734094;40183.59357422476;40246.79876600598;40362.59637403647;40432;42459;42521.57478425238;42550.57449425466;42578.36132458015;42712;11283.830742538868;11386.94306528462;11461.369624670722;11502.137339699557;11502.194846360842;9154.954225228965;9172.44965302084;9176.220021298264;9177.678781242757;9194.264458843276;12557.372131393393;12652.683682908;12660.430280637393;12736.872631273754;12790;5205.5315021647475;5312.92030619541;5359.651622644516;5405.081136206775;5471.534919531805;856.6573370651664;857.2970164465204;874.7026011156238;884.681824082113;897.4301318662697;20632.489056124996;21478.57042859134;21689.67465488019;21706.240281590068;21753.564928701653;938.4979036215728;948.2650945517279;950.6577632052456;963.0754475703263;966.6906589891308;10720.731981700364;11302.604408845651;11319.830202546967;11327;11515.654530364103;223801;224932;226059;226286;226348;43809.56190438118;43948.12103757907;44233.778831105636;44271.557284427385;44439.55560444419;1181.468339247342;1204.7891618966646;1214.9271043737403;1224.5958833584896;1228.9385530723607;19955.401337959884;19962.30131945375;21033.89483052575;21169.57660846805;21459.78540214578;31264;31358.05925822229;31364.215894602818;31552.368952621277;31634.841825790725;208712;209017;209477;209765;210516;27490.587641184997;28032.159035228975;28052.85973570119;28077.034607577272;28724;32736.34527309488;32953.34093318168;33214;33975;34042.489362659086;25696.357591059626;26256.21231363062;27432.45135097247;27696.861515692293;28723.425531488836;27689;27708.168754937386;27759.722402776522;27857.58213626838;28821.85589072125;29883.252918677208;30773.692263077977;30847.537286941162;30882.227944301572;30995.225119371295;26933.730662693906;27204.45591088207;27230.455390892468;27637.861810690818;28291;20945.685814712488;22145.11419543265;22301.553968920205;22514.437139071;22540.887295563418 19:21:16 INFO - PID 10102 | |2;jquery.html;409.4472462176061;413.8386029448516;423.8770756480621;426.31363504757337;441.9315006174042;14913.701725965475;17648.47054588361;17972.55068623285;18316.900985940854;18317.267309307645;16113.27490262938;16332.510024699248;16354;16408.09755463449;16584.50246492604;5613.550915926716;5637.943620563793;5729.684867332295;5875.911861322063;5880.5883588148845;5703.429657034305;5747.885042299152;5770.855728606776;5791.565632577553;5806.564507661921;5519.724013799314;5640.210370548127;5688;5729.627574207684;5759;5707.400722924095;5735.741891614845;5762.538996880239;5768.711564421762;5775.826725198251;4971.27916452116;5136.280920671109;5169.819056333048;5188.584913206934;5191.351081114861;21732.565348693097;21844.781552184435;21859.453513662127;21879.781202187933;22122.557548848934;1493.9925300373536;1499.0705762427256;1504.210289597959;1527.6333679916852;1539.7151526967434;13414;13615.183089014592;13780.517681881087;14249.073810202408;14278.071925324924;1608.921933085502;1629.2179753718162;1697.6095498035397;1703.880728349016;1751.2382113780545;75408.24591754067;77146.61426692887;77200.22799771986;86452;89968.55015724945;10890.782184356427;10991.120710343313;11069.446527673745;11148.777024459465;11318.660440186808;13418.865811341957;15674.9216253918;15695.058296502246;15703.607409814846;15710.607234819221;6618.437432818168;6836.316368363224;7118.572885626879;7119.038929744522;7158.2483839197175;6209.285932117774;6333.651649159248;6397.136386587844;6526.836829079216;6545.770898018546;7028.578285302899;7041.260667629927;7100.112485939258;7143.63336395871;7253.347198752032;2111.2082968886666;2116.8200702940117;2131.563029578964;2135.8504904656834;2210.1159536185655;825.6037102190982;849.4987957105214;882.571952602987;884.2616415293173;905.5970093308546;16510.917445412695;17031.233594488276;17064.829351706325;17318.047507387215;17415.91292043557;874.9868751968726;877.6664867350366;882.6513527156866;902.7291812456236;908.8545832666741;8984.416012959136;9643.180329671915;9681.419114853132;9685.854712179324;9703.563339649732;418522;419647;420095;443366;449214;87074;88353;88477;88743;88804.555977221;1065.6217042949797;1070.6895000449783;1077.5258886090096;1098.0501865885951;1157.35188294557;16543.917280414003;16888.66222675564;17348.219330130425;17886.910565447088;18161.909190453964;41193;41628;42072.36891446692;42335.36496952487;42532.1493570133;52747.20879186892;52903.20645190248;53352;55386.72306638441;55501.44498554963;7708.807279818049;7751.844963100819;7829.373650108091;7855.057393112863;8188.05837328691;11570.421478926188;11852;12009.159358844798;12132;12147.33189674541;9879;10003.249756268455;10213.285070045322;10366.170706343324;10399.32404393712;9431.481268530297;9827.11555959967;9998.900011000087;10023.899761002296;10161.847572286273;9788.168005719594;10166.288359814742;10281.794364112826;10331.483425828528;10603.89396106029;7395.482316238027;7469.215732348025;7546.434017448603;7702.537847729154;7802.804929876572;9761;9912.504374781089;10106.747331316481;10275.280730348804;10361.356932153369 19:21:16 INFO - PID 10102 | |3;mootools.html;1229.1396022784052;1289.5679947217682;1318.5714642741107;1319.3535167767798;1323.3317174826711;9274.953625231872;9663.565139568718;9764.023597640242;9775.902240977588;10013.299069065168;9696;9838.508074596259;9839.360441571293;9849.852252216222;9878.901210987888;2131.2114517628497;2144.2066435418915;2159.1039718516877;2160.4274867160216;2168.9783102168935;2092.5082605587677;2110.873347599149;2117.311873641065;2174.521605246843;2178.21584229678;2115.471132216946;2149.924752633658;2208.7018252535945;2224.3882932193696;2225.2100504320974;2127.755308139568;2130.8508404411696;2134.423705599487;2137.690034944932;2141.7858214178614;1780.4035648057786;1845.5570663040908;2017.122551690005;2082.4481512399225;2125.192426877792;9764.951175244149;9831.754206144831;9890.30767846251;9904.207663386911;9923.561083642904;4996.400431948153;5143.639945203838;5183.067047931371;5186.299849520342;5189.273501709764;3059.1587313488744;3084.383123375334;3127.5934128563367;3141.575887255214;3222.3555288942307;987.4322264697828;998.8651532043226;1002.2382988928395;1007.9244056695704;1022.6420752736483;13596.728065438734;13700.52048178319;13781.931090344584;13840.9999999999;13878.375473103633;4841.05599408112;4915.16442204826;4988.301637770715;5075.56857667095;5111.616628752859;11920.940395297968;12016.339101349335;12032.217905836093;12035.699107522381;12059.095567832448;5334.413214546396;5358.276632654542;5359.08895487768;5370.462953704677;5386;4630.282306242538;4684.6486513510945;4732.905341893143;4790.4969978152485;4809.302651115569;3914.9021274467796;4074.409210664437;4078.2659121357847;4115.773632450184;4119.340905455173;1275.79587266037;1281.641140480667;1294.5922034559085;1311.6917524381763;1320.2078752748466;670.607694498714;694.0768777525878;696.4150113904243;700.7687463137153;710.9786706398817;5223.4776522347465;5232.2674825524455;5327.413984461784;5350.1439769637445;5429.049916264717;541.1179776963525;553.3857418265721;553.7037684838592;557.882844602638;568.4713216708501;3406.9659303407143;3497.597776255763;3547.077759782475;3596.622354652724;3675.4119340905327;11361.602343917923;11733.35466549348;12133.15067945253;12335.50657973671;12535.686607834694;12151.696207594881;12506.124571279923;12512.624621261377;12713.42789574453;12812.743745125046;9205.631774728936;9218.308626853013;9237.584308706124;9329.16037556623;9338.112879276458;6191.380861913953;6337.112804207322;6341.651209183355;6427.1002059710745;6517.217933847779;11616.88383116158;11628.418579071182;11646.301221926373;11833.171677982458;11925.403729813648;11848.585299514476;11897.643070707893;11963.700907477383;11988.400579970792;12192.963598094262;8066.112727600077;8232.794180145544;8278.213569710868;8283.875741863998;8292.419530632798;9255.86116208244;9282.303827213122;9339.20616747584;9356.81286374255;9412.717618471457;7505.699772009277;7621.12357078943;7623.65693543803;7638.770836874903;7644.770656880302;7557.735479258199;7622.885656715042;7641.694332226649;7668.961655191688;7840.490368126054;7057.858842823218;7069.858602828018;7076.575405475688;7109.75115870942;7185.461090418135;4738.360321356573;4763.261694437368;5214.5567626750635;5344.9732751336;5373.731313434391;4848.684835485682;4925.359703238556;4969.47820478859;5006;5031.345925029723 19:21:16 INFO - PID 10102 | |4;prototype.html;363.1647211413749;389.6415297925908;389.85965052581065;392.56033242768103;400.9398590211468;5590.385057643661;5627.385543854031;5659.122835960427;5671.262735844345;5718.428157184279;5551.8889622207635;5561.721913904309;5566.997940370732;5573.665580065199;5588.524975377098;4032.254033003889;4222.788860556975;4287.9356809647725;4288.635465985395;4447.733136011833;4269.935950960738;4270.530241673413;4275.40144379787;4282.828686852522;4294.849680261192;4258.339957306623;4258.659307255428;4263.360495925605;4267.14657068586;4270.252705776492;4153.937690934608;4220.451341325608;4248.87253382399;4267.530571637133;4273.572642735733;3669.7064234861145;3686.3548878946344;3686.8156592170285;3693.501377314055;3695.1870588470492;5386.569074474072;5395.165643681128;5399.298091248152;5418.320320700595;5449.3188351456065;4768.928466073012;4871.391076115486;4918.803247870081;4930.359053323045;4936.901261974776;5832.1834943108;5854.385289544579;5859.794907178229;5870.148828419898;5879.67661778602;4048.3725022621543;4074.388841673743;4078.5717499662405;4079.1229885574744;4087.7751723655188;5874.9118763218585;6065.909011364833;6196.318404975449;6241.875162496724;6284.2458904931245;4189.141226048653;4193.329067349209;4199.832006719758;4202.474690663667;4208.957910420918;4220.409142720022;4230.534641189467;4236.851710190129;4265.573442655772;4277.914441711148;4780.211265141283;4839;4861.319415281863;4878.634102442331;4886.780094895738;5828.154917536934;5840.415958404125;5841.591088623755;5859.53123750099;5873.970630146822;1457.679310551677;1463.6121427821636;1467.7064587082625;1471.1981969826256;1472.5950363649868;932.2167799020388;975.7853272280087;977.9902200978041;979.8187335342984;988.545269176187;5132.8460146195675;5139.563137133386;5146.768395422215;5147.227915812583;5147.271945868695;6083.72241829212;6083.958020989505;6093.055576385667;6098.603590766586;6101.725422355916;4923.286123512071;5093;5133.204353325241;5156.9742151289;5165.483451654804;3208.4385232584204;3229.5963004624423;3246.1397729601676;3263.249452625862;3268.9019329420157;5541.7303790762835;5711.8000869969355;5714.571407144481;5727.455891690282;5728.885422291531;6248.75004999804;6270.3416141305415;6332.335104813928;6336.493080553545;6357.904631430532;5693.405846363025;5697.544196464356;5698.715064246854;5703.9429605704245;5705.800296989585;5954.821355359346;6047.09293605945;6086.847828804138;6106.1451396803595;6108;5997.670128142994;6010.819675409744;6018.398160183947;6025.276966764016;6033.396660333931;5379.704116273642;5479.123340265538;5541.3904470507405;5630.155476678531;5644.774209031592;4169.749815011109;4177.436046133855;4185.22573323936;4211;4211.0946146578635;5968.166449415482;6119.694015299128;6125.632462052291;6128.601640893506;6133.110698948538;5889.469947704727;5911.054231322968;5913.476190714193;5919.704014799329;5923.600941618652;5886.793962211302;5889.234399528034;5892.94107058924;5895.174675545341;5943.138244954544;5572.3034620672415;5740.311162660508;5783.913241301468;5871.4715675589405;5874.735636896436;5954.136650185786;5958.080540535193;5983.282006159288;6013.248343957005;6047.274327080779;5673.290838645169;5783;5871.1486834409625;5896.469317761422;5908.527317814651 19:21:16 INFO - PID 10102 | |5;yui.html;572.464745462992;603.5955909540606;610.6549799363362;619.0343064818883;636.0237036149512;10502.369857808528;11163.944180279097;11166.776664466715;11192.44037798111;11196.440177991108;10682.572697092126;11262.662120136389;11388.08895288377;11493.482793274301;11513.078953683706;792.1128336263394;794.3208556684039;804.6379129391768;807.90709068457;824.4393812207696;817.6647574494458;822.1039067416515;826.7519744076783;827.028241815867;828.6229765456703;864.2049314630524;865.9567021648924;866.5320726807516;867.7049803066956;868.1492137705021;860.096898256834;861.332467337812;861.9138086191393;862.1421685423044;862.9395942284043;635.4154178156061;637.2416823979496;637.3785559079906;638.565775272819;639.3350915048344;12668.619941401772;12887.613371598867;12971.221726696429;12980.350982450935;13083.934580327134;13541.187528748307;14051.20294578652;14110.576682699535;14321.928390358085;14370.768211326587;8838.911610883937;8904.6197839335;9071.365004449692;9160.954195229047;9522.285828562815;2342.9179978700663;2378.5242951409787;2409.8072154227793;2448.9387765305833;2460.3849037740565;67433;68642.65678671574;69220;69967.3003269971;70244.64877675578;9571.234301255883;9661.372010819274;9719.465429401309;9780.853287200698;9971.202303815677;18806.435806925812;18839.24643014264;18854.52863678419;18991.90504047471;18998.81001189998;5585.609007369445;5639.661620302795;5684.801031963944;5820.039693450618;5846.561507886926;3065.325628361757;3067.7239048485744;3111.7199452049426;3114.486109791859;3115.4703700370537;3164.4620414529127;3706.703463722896;3859.6333348331864;3860.4595356650093;3864.2464719380014;699.2483080688179;702.7294491620763;704.2745971649209;714.1608609883366;726.6185252742353;486.8977514721948;496.3919198981219;501.3282201849539;504.1731560241207;511.56516960583207;7465.29079737424;7884.211578842184;8206.876896846552;8403.000214872141;8654.264387527004;485.2071595454761;493.47198497607934;503.7531609511313;516.2694786876602;521.1843464977298;3496.650334966534;3516.2088530080528;3597.6042635310096;3676.3198808220563;3704.4628528863163;53326.73336633292;55577.722111389994;56465;57718.7114064427;57916.131258031164;51404.48595514072;51853.7407312961;51906;52478.737606311726;52590.73704631453;45810.312845307344;45917.77041114773;46868.53131468778;47334.52665473301;47993;7146.392556632536;7417.851642967218;7441.4046876248685;7556.924430755622;7606.771796846104;23838;24095.156669516484;24206.394840129138;24496.632550512113;24856.130035448674;29929.401411972074;30197.547036794025;30511;30902.53646195354;31491.527627085154;8947.776305592412;8955.59699813497;9018.458892466473;9159.267258619162;9369.672061477815;9956.103950644478;10022.3485473444;10180.134688551556;10190.388576685422;10573.154147668321;9071.90928090737;9378.202852757591;9567;9579.23366130694;9948.651797187063;9114.726558203265;9138.68014619485;9274.675386361445;9635.710928672152;9739.610415583298;8452.112528184452;8669.6098675561;8689.695860644848;9088.636454541744;9090;6841.21326047491;6852.725890964306;6964.721411143498;6991.091158149408;7120.394766444703;7666;7738.187490313436;7962.641681124247;8017.679292828221;8095.23095305945 19:21:16 INFO - PID 10102 | __end_tp_report 19:21:16 INFO - PID 10102 | __start_cc_report 19:21:16 INFO - PID 10102 | _x_x_mozilla_cycle_collect,390 19:21:16 INFO - PID 10102 | __end_cc_report 19:21:16 INFO - PID 10102 | __startTimestamp1490322076775__endTimestamp 19:21:16 INFO - PID 10102 | 19:21:16 INFO - PID 10102 | ------- Summary: start ------- 19:21:16 INFO - PID 10102 | Number of tests: 6 19:21:16 INFO - PID 10102 | 19:21:16 INFO - PID 10102 | [#0] dojo.html Cycles:165 Average:5081.18 Median:5237.53 stddev:572.15 (10.9%) stddev-sans-first:541.55 19:21:16 INFO - PID 10102 | Values: 2663.2 2674.8 2690.5 2699.7 2718.6 5038.0 5070.1 5087.4 5162.0 5186.7 5064.2 5163.4 5169.7 5232.1 5235.8 4659.8 4664.9 4683.6 4689.3 4714.1 4728.2 4756.7 4757.3 4776.3 4812.4 4690.2 4694.2 4699.6 4721.2 4726.6 4716.7 4720.1 4734.1 4748.8 4768.1 4622.4 4655.8 4676.0 4705.7 4726.3 4937.0 4938.9 4991.6 4991.7 5144.1 5426.8 5428.3 5429.8 5431.7 5433.6 5447.3 5481.0 5490.8 5492.2 5494.4 5031.2 5095.8 5096.7 5101.2 5106.5 5591.8 5597.7 5599.2 5601.2 5601.7 5324.6 5444.4 5477.0 5516.8 5532.0 5571.0 5592.9 5601.6 5604.0 5641.3 5536.1 5553.1 5553.5 5556.0 5566.3 5354.2 5415.6 5506.0 5543.1 5611.9 4562.9 4576.1 4595.0 4605.3 4609.4 3944.5 3949.9 3983.4 3990.5 4003.4 4702.0 4754.8 4778.7 4819.8 4819.8 5569.7 5593.6 5595.3 5605.0 5619.4 4836.6 4845.7 4855.2 4856.2 4892.9 4797.1 4840.6 4966.0 4966.8 4981.6 5080.3 5081.1 5082.8 5083.4 5087.1 5367.6 5405.7 5412.6 5418.6 5429.5 5214.6 5233.2 5237.5 5277.2 5280.7 5422.9 5459.5 5486.8 5497.1 5497.1 5436.5 5569.8 5573.4 5585.2 5630.2 5308.7 5430.5 5437.4 5476.5 5482.8 5411.8 5448.4 5465.0 5467.5 5473.1 5327.5 5339.4 5397.3 5400.0 5439.7 5324.9 5357.0 5359.4 5359.9 5369.0 5310.0 5338.6 5355.2 5373.9 5384.7 19:21:16 INFO - PID 10102 | 19:21:16 INFO - PID 10102 | [#1] ext.html Cycles:180 Average:32989.96 Median:30801.85 stddev:50832.13 (165.0%) stddev-sans-first:50916.39 19:21:16 INFO - PID 10102 | Values: 553.9 611.2 625.5 1162.9 1190.7 32293.0 32819.2 33059.2 33125.0 33183.7 30359.7 30730.8 30830.0 30876.4 30884.8 6800.7 7140.7 7290.2 7294.2 7301.8 7406.8 7413.4 7440.9 7487.5 7511.8 7461.7 7520.7 7530.6 7533.1 7544.5 7408.7 7489.4 7512.4 7638.1 7668.0 7344.2 7394.1 7395.1 7402.3 7405.4 32936.3 33270.5 33274.2 33416.5 33462.0 2632.7 2647.8 2663.2 2668.6 2686.2 23588.3 23690.9 24018.5 24228.3 24887.9 2631.8 2653.7 2654.9 2655.3 2682.1 112687.4 113435.0 154841.0 155199.0 155417.0 39334.2 40183.6 40246.8 40362.6 40432.0 42459.0 42521.6 42550.6 42578.4 42712.0 11283.8 11386.9 11461.4 11502.1 11502.2 9155.0 9172.4 9176.2 9177.7 9194.3 12557.4 12652.7 12660.4 12736.9 12790.0 5205.5 5312.9 5359.7 5405.1 5471.5 856.7 857.3 874.7 884.7 897.4 20632.5 21478.6 21689.7 21706.2 21753.6 938.5 948.3 950.7 963.1 966.7 10720.7 11302.6 11319.8 11327.0 11515.7 223801.0 224932.0 226059.0 226286.0 226348.0 43809.6 43948.1 44233.8 44271.6 44439.6 1181.5 1204.8 1214.9 1224.6 1228.9 19955.4 19962.3 21033.9 21169.6 21459.8 31264.0 31358.1 31364.2 31552.4 31634.8 208712.0 209017.0 209477.0 209765.0 210516.0 27490.6 28032.2 28052.9 28077.0 28724.0 32736.3 32953.3 33214.0 33975.0 34042.5 25696.4 26256.2 27432.5 27696.9 28723.4 27689.0 27708.2 27759.7 27857.6 28821.9 29883.3 30773.7 30847.5 30882.2 30995.2 26933.7 27204.5 27230.5 27637.9 28291.0 20945.7 22145.1 22301.6 22514.4 22540.9 19:21:16 INFO - PID 10102 | 19:21:16 INFO - PID 10102 | [#2] jquery.html Cycles:180 Average:26677.65 Median:221903.97 stddev:71295.08 (32.1%) stddev-sans-first:71467.80 19:21:16 INFO - PID 10102 | Values: 409.4 413.8 423.9 426.3 441.9 14913.7 17648.5 17972.6 18316.9 18317.3 16113.3 16332.5 16354.0 16408.1 16584.5 5613.6 5637.9 5729.7 5875.9 5880.6 5703.4 5747.9 5770.9 5791.6 5806.6 5519.7 5640.2 5688.0 5729.6 5759.0 5707.4 5735.7 5762.5 5768.7 5775.8 4971.3 5136.3 5169.8 5188.6 5191.4 21732.6 21844.8 21859.5 21879.8 22122.6 1494.0 1499.1 1504.2 1527.6 1539.7 13414.0 13615.2 13780.5 14249.1 14278.1 1608.9 1629.2 1697.6 1703.9 1751.2 75408.2 77146.6 77200.2 86452.0 89968.6 10890.8 10991.1 11069.4 11148.8 11318.7 13418.9 15674.9 15695.1 15703.6 15710.6 6618.4 6836.3 7118.6 7119.0 7158.2 6209.3 6333.7 6397.1 6526.8 6545.8 7028.6 7041.3 7100.1 7143.6 7253.3 2111.2 2116.8 2131.6 2135.9 2210.1 825.6 849.5 882.6 884.3 905.6 16510.9 17031.2 17064.8 17318.0 17415.9 875.0 877.7 882.7 902.7 908.9 8984.4 9643.2 9681.4 9685.9 9703.6 418522.0 419647.0 420095.0 443366.0 449214.0 87074.0 88353.0 88477.0 88743.0 88804.6 1065.6 1070.7 1077.5 1098.1 1157.4 16543.9 16888.7 17348.2 17886.9 18161.9 41193.0 41628.0 42072.4 42335.4 42532.1 52747.2 52903.2 53352.0 55386.7 55501.4 7708.8 7751.8 7829.4 7855.1 8188.1 11570.4 11852.0 12009.2 12132.0 12147.3 9879.0 10003.2 10213.3 10366.2 10399.3 9431.5 9827.1 9998.9 10023.9 10161.8 9788.2 10166.3 10281.8 10331.5 10603.9 7395.5 7469.2 7546.4 7702.5 7802.8 9761.0 9912.5 10106.7 10275.3 10361.4 19:21:16 INFO - PID 10102 | 19:21:16 INFO - PID 10102 | [#3] mootools.html Cycles:180 Average:6130.88 Median:4825.18 stddev:3909.55 (81.0%) stddev-sans-first:3903.17 19:21:16 INFO - PID 10102 | Values: 1229.1 1289.6 1318.6 1319.4 1323.3 9275.0 9663.6 9764.0 9775.9 10013.3 9696.0 9838.5 9839.4 9849.9 9878.9 2131.2 2144.2 2159.1 2160.4 2169.0 2092.5 2110.9 2117.3 2174.5 2178.2 2115.5 2149.9 2208.7 2224.4 2225.2 2127.8 2130.9 2134.4 2137.7 2141.8 1780.4 1845.6 2017.1 2082.4 2125.2 9765.0 9831.8 9890.3 9904.2 9923.6 4996.4 5143.6 5183.1 5186.3 5189.3 3059.2 3084.4 3127.6 3141.6 3222.4 987.4 998.9 1002.2 1007.9 1022.6 13596.7 13700.5 13781.9 13841.0 13878.4 4841.1 4915.2 4988.3 5075.6 5111.6 11920.9 12016.3 12032.2 12035.7 12059.1 5334.4 5358.3 5359.1 5370.5 5386.0 4630.3 4684.6 4732.9 4790.5 4809.3 3914.9 4074.4 4078.3 4115.8 4119.3 1275.8 1281.6 1294.6 1311.7 1320.2 670.6 694.1 696.4 700.8 711.0 5223.5 5232.3 5327.4 5350.1 5429.0 541.1 553.4 553.7 557.9 568.5 3407.0 3497.6 3547.1 3596.6 3675.4 11361.6 11733.4 12133.2 12335.5 12535.7 12151.7 12506.1 12512.6 12713.4 12812.7 9205.6 9218.3 9237.6 9329.2 9338.1 6191.4 6337.1 6341.7 6427.1 6517.2 11616.9 11628.4 11646.3 11833.2 11925.4 11848.6 11897.6 11963.7 11988.4 12193.0 8066.1 8232.8 8278.2 8283.9 8292.4 9255.9 9282.3 9339.2 9356.8 9412.7 7505.7 7621.1 7623.7 7638.8 7644.8 7557.7 7622.9 7641.7 7669.0 7840.5 7057.9 7069.9 7076.6 7109.8 7185.5 4738.4 4763.3 5214.6 5345.0 5373.7 4848.7 4925.4 4969.5 5006.0 5031.3 19:21:16 INFO - PID 10102 | 19:21:16 INFO - PID 10102 | [#4] prototype.html Cycles:180 Average:4856.44 Median:5564.36 stddev:1440.01 (25.9%) stddev-sans-first:1404.00 19:21:16 INFO - PID 10102 | Values: 363.2 389.6 389.9 392.6 400.9 5590.4 5627.4 5659.1 5671.3 5718.4 5551.9 5561.7 5567.0 5573.7 5588.5 4032.3 4222.8 4287.9 4288.6 4447.7 4269.9 4270.5 4275.4 4282.8 4294.8 4258.3 4258.7 4263.4 4267.1 4270.3 4153.9 4220.5 4248.9 4267.5 4273.6 3669.7 3686.4 3686.8 3693.5 3695.2 5386.6 5395.2 5399.3 5418.3 5449.3 4768.9 4871.4 4918.8 4930.4 4936.9 5832.2 5854.4 5859.8 5870.1 5879.7 4048.4 4074.4 4078.6 4079.1 4087.8 5874.9 6065.9 6196.3 6241.9 6284.2 4189.1 4193.3 4199.8 4202.5 4209.0 4220.4 4230.5 4236.9 4265.6 4277.9 4780.2 4839.0 4861.3 4878.6 4886.8 5828.2 5840.4 5841.6 5859.5 5874.0 1457.7 1463.6 1467.7 1471.2 1472.6 932.2 975.8 978.0 979.8 988.5 5132.8 5139.6 5146.8 5147.2 5147.3 6083.7 6084.0 6093.1 6098.6 6101.7 4923.3 5093.0 5133.2 5157.0 5165.5 3208.4 3229.6 3246.1 3263.2 3268.9 5541.7 5711.8 5714.6 5727.5 5728.9 6248.8 6270.3 6332.3 6336.5 6357.9 5693.4 5697.5 5698.7 5703.9 5705.8 5954.8 6047.1 6086.8 6106.1 6108.0 5997.7 6010.8 6018.4 6025.3 6033.4 5379.7 5479.1 5541.4 5630.2 5644.8 4169.7 4177.4 4185.2 4211.0 4211.1 5968.2 6119.7 6125.6 6128.6 6133.1 5889.5 5911.1 5913.5 5919.7 5923.6 5886.8 5889.2 5892.9 5895.2 5943.1 5572.3 5740.3 5783.9 5871.5 5874.7 5954.1 5958.1 5983.3 6013.2 6047.3 5673.3 5783.0 5871.1 5896.5 5908.5 19:21:16 INFO - PID 10102 | 19:21:16 INFO - PID 10102 | [#5] yui.html Cycles:180 Average:13007.79 Median:607.13 stddev:16859.10 (2776.9%) stddev-sans-first:16880.54 19:21:16 INFO - PID 10102 | Values: 572.5 603.6 610.7 619.0 636.0 10502.4 11163.9 11166.8 11192.4 11196.4 10682.6 11262.7 11388.1 11493.5 11513.1 792.1 794.3 804.6 807.9 824.4 817.7 822.1 826.8 827.0 828.6 864.2 866.0 866.5 867.7 868.1 860.1 861.3 861.9 862.1 862.9 635.4 637.2 637.4 638.6 639.3 12668.6 12887.6 12971.2 12980.4 13083.9 13541.2 14051.2 14110.6 14321.9 14370.8 8838.9 8904.6 9071.4 9161.0 9522.3 2342.9 2378.5 2409.8 2448.9 2460.4 67433.0 68642.7 69220.0 69967.3 70244.6 9571.2 9661.4 9719.5 9780.9 9971.2 18806.4 18839.2 18854.5 18991.9 18998.8 5585.6 5639.7 5684.8 5820.0 5846.6 3065.3 3067.7 3111.7 3114.5 3115.5 3164.5 3706.7 3859.6 3860.5 3864.2 699.2 702.7 704.3 714.2 726.6 486.9 496.4 501.3 504.2 511.6 7465.3 7884.2 8206.9 8403.0 8654.3 485.2 493.5 503.8 516.3 521.2 3496.7 3516.2 3597.6 3676.3 3704.5 53326.7 55577.7 56465.0 57718.7 57916.1 51404.5 51853.7 51906.0 52478.7 52590.7 45810.3 45917.8 46868.5 47334.5 47993.0 7146.4 7417.9 7441.4 7556.9 7606.8 23838.0 24095.2 24206.4 24496.6 24856.1 29929.4 30197.5 30511.0 30902.5 31491.5 8947.8 8955.6 9018.5 9159.3 9369.7 9956.1 10022.3 10180.1 10190.4 10573.2 9071.9 9378.2 9567.0 9579.2 9948.7 9114.7 9138.7 9274.7 9635.7 9739.6 8452.1 8669.6 8689.7 9088.6 9090.0 6841.2 6852.7 6964.7 6991.1 7120.4 7666.0 7738.2 7962.6 8017.7 8095.2 19:21:16 INFO - PID 10102 | -------- Summary: end -------- 19:21:16 INFO - PID 10102 | 19:21:17 INFO - TEST-INFO | 10102: exit 0 19:21:17 INFO - TEST-OK | dromaeo_css | took 1121224ms 19:21:17 INFO - TEST-START | kraken 19:21:17 INFO - operating with platform_type : linux_ 19:21:17 INFO - Initialising browser for kraken test... 19:21:17 INFO - TEST-INFO | started process 10480 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW4EHS2/profile http://localhost:52760/getInfo.html) 19:21:18 INFO - PID 10480 | 19:21:18 INFO - PID 10480 | { 19:21:18 INFO - PID 10480 | "TopSites": { 19:21:18 INFO - PID 10480 | "rows": [ 19:21:18 INFO - PID 10480 | { 19:21:18 INFO - PID 10480 | "title": "Facebook", 19:21:18 INFO - PID 10480 | "url": "https://www.facebook.com/" 19:21:18 INFO - PID 10480 | }, 19:21:18 INFO - PID 10480 | { 19:21:18 INFO - PID 10480 | "title": "YouTube", 19:21:18 INFO - PID 10480 | "url": "https://www.youtube.com/" 19:21:18 INFO - PID 10480 | }, 19:21:18 INFO - PID 10480 | { 19:21:18 INFO - PID 10480 | "title": "Amazon", 19:21:18 INFO - PID 10480 | "url": "http://www.amazon.com/" 19:21:18 INFO - PID 10480 | }, 19:21:18 INFO - PID 10480 | { 19:21:18 INFO - PID 10480 | "title": "Yahoo", 19:21:18 INFO - PID 10480 | "url": "https://www.yahoo.com/" 19:21:18 INFO - PID 10480 | }, 19:21:18 INFO - PID 10480 | { 19:21:18 INFO - PID 10480 | "title": "eBay", 19:21:18 INFO - PID 10480 | "url": "http://www.ebay.com" 19:21:18 INFO - PID 10480 | }, 19:21:18 INFO - PID 10480 | { 19:21:18 INFO - PID 10480 | "title": "Twitter", 19:21:18 INFO - PID 10480 | "url": "https://twitter.com/" 19:21:18 INFO - PID 10480 | } 19:21:18 INFO - PID 10480 | ] 19:21:18 INFO - PID 10480 | } 19:21:18 INFO - PID 10480 | } 19:21:22 INFO - PID 10480 | __metrics Screen width/height:1600/1200 19:21:22 INFO - PID 10480 | colorDepth:24 19:21:22 INFO - PID 10480 | Browser inner width/height: 1024/697 19:21:22 INFO - PID 10480 | __metrics 19:21:23 ERROR - PID 10480 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3388: TypeError: this.tabs is undefined 19:21:24 INFO - TEST-INFO | 10480: exit 0 19:21:24 INFO - Browser initialized. 19:21:24 INFO - Running cycle 1/1 for kraken test... 19:21:24 INFO - TEST-INFO | started process 10611 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW4EHS2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:21:24 INFO - PID 10611 | 19:21:24 INFO - PID 10611 | { 19:21:24 INFO - PID 10611 | "TopSites": { 19:21:24 INFO - PID 10611 | "rows": [ 19:21:24 INFO - PID 10611 | { 19:21:24 INFO - PID 10611 | "title": "Facebook", 19:21:24 INFO - PID 10611 | "url": "https://www.facebook.com/" 19:21:24 INFO - PID 10611 | }, 19:21:24 INFO - PID 10611 | { 19:21:24 INFO - PID 10611 | "title": "YouTube", 19:21:24 INFO - PID 10611 | "url": "https://www.youtube.com/" 19:21:24 INFO - PID 10611 | }, 19:21:24 INFO - PID 10611 | { 19:21:24 INFO - PID 10611 | "title": "Amazon", 19:21:24 INFO - PID 10611 | "url": "http://www.amazon.com/" 19:21:24 INFO - PID 10611 | }, 19:21:24 INFO - PID 10611 | { 19:21:24 INFO - PID 10611 | "title": "Yahoo", 19:21:24 INFO - PID 10611 | "url": "https://www.yahoo.com/" 19:21:24 INFO - PID 10611 | }, 19:21:24 INFO - PID 10611 | { 19:21:24 INFO - PID 10611 | "title": "eBay", 19:21:24 INFO - PID 10611 | "url": "http://www.ebay.com" 19:21:24 INFO - PID 10611 | }, 19:21:24 INFO - PID 10611 | { 19:21:24 INFO - PID 10611 | "title": "Twitter", 19:21:24 INFO - PID 10611 | "url": "https://twitter.com/" 19:21:24 INFO - PID 10611 | } 19:21:24 INFO - PID 10611 | ] 19:21:24 INFO - PID 10611 | } 19:21:24 INFO - PID 10611 | } 19:21:36 INFO - PID 10611 | RSS: Main: 156823552 19:21:36 INFO - PID 10611 | 19:21:39 INFO - PID 10611 | Cycle 1(1): loaded http://localhost:52760/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52760/tests/kraken/driver.html?testName=audio-beat-detection) 19:21:40 INFO - PID 10611 | RSS: Main: 162263040 19:21:40 INFO - PID 10611 | 19:21:42 INFO - PID 10611 | Cycle 1(1): loaded http://localhost:52760/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52760/tests/kraken/driver.html?testName=audio-dft) 19:21:43 INFO - PID 10611 | RSS: Main: 161329152 19:21:43 INFO - PID 10611 | 19:21:46 INFO - PID 10611 | Cycle 1(1): loaded http://localhost:52760/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52760/tests/kraken/driver.html?testName=audio-fft) 19:21:47 INFO - PID 10611 | RSS: Main: 158138368 19:21:47 INFO - PID 10611 | 19:21:49 INFO - PID 10611 | Cycle 1(1): loaded http://localhost:52760/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52760/tests/kraken/driver.html?testName=audio-oscillator) 19:21:49 INFO - PID 10611 | RSS: Main: 159195136 19:21:49 INFO - PID 10611 | 19:21:52 INFO - PID 10611 | Cycle 1(1): loaded http://localhost:52760/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52760/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:21:52 INFO - PID 10611 | RSS: Main: 159223808 19:21:52 INFO - PID 10611 | 19:21:55 INFO - PID 10611 | Cycle 1(1): loaded http://localhost:52760/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52760/tests/kraken/driver.html?testName=imaging-darkroom) 19:21:56 INFO - PID 10611 | RSS: Main: 164589568 19:21:56 INFO - PID 10611 | 19:22:00 INFO - PID 10611 | Cycle 1(1): loaded http://localhost:52760/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52760/tests/kraken/driver.html?testName=imaging-desaturate) 19:22:00 INFO - PID 10611 | RSS: Main: 161927168 19:22:00 INFO - PID 10611 | 19:22:03 INFO - PID 10611 | Cycle 1(1): loaded http://localhost:52760/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52760/tests/kraken/driver.html?testName=json-parse-financial) 19:22:04 INFO - PID 10611 | RSS: Main: 163446784 19:22:04 INFO - PID 10611 | 19:22:06 INFO - PID 10611 | Cycle 1(1): loaded http://localhost:52760/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52760/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:22:06 INFO - PID 10611 | RSS: Main: 163586048 19:22:06 INFO - PID 10611 | 19:22:08 INFO - PID 10611 | Cycle 1(1): loaded http://localhost:52760/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52760/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:22:09 INFO - PID 10611 | RSS: Main: 163250176 19:22:09 INFO - PID 10611 | 19:22:11 INFO - PID 10611 | Cycle 1(1): loaded http://localhost:52760/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52760/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:22:12 INFO - PID 10611 | RSS: Main: 163819520 19:22:12 INFO - PID 10611 | 19:22:14 INFO - PID 10611 | Cycle 1(1): loaded http://localhost:52760/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52760/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:22:15 INFO - PID 10611 | RSS: Main: 164143104 19:22:15 INFO - PID 10611 | 19:22:18 INFO - PID 10611 | Cycle 1(1): loaded http://localhost:52760/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52760/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:22:19 INFO - PID 10611 | RSS: Main: 166768640 19:22:19 INFO - PID 10611 | 19:22:21 INFO - PID 10611 | Cycle 1(1): loaded http://localhost:52760/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52760/tests/kraken/driver.html?testName=ai-astar) 19:22:21 INFO - PID 10611 | RSS: Main: 167776256 19:22:21 INFO - PID 10611 | 19:22:21 INFO - PID 10611 | __start_tp_report 19:22:21 INFO - PID 10611 | _x_x_mozilla_page_load 19:22:21 INFO - PID 10611 | _x_x_mozilla_page_load_details 19:22:21 INFO - PID 10611 | |i|pagename|runs| 19:22:21 INFO - PID 10611 | |0;ai-astar;103;113;113;111;112;114;112;112;110;111 19:22:21 INFO - PID 10611 | |1;audio-beat-detection;154;128;129;174;125;125;127;125;152;126 19:22:21 INFO - PID 10611 | |2;audio-dft;164;166;165;169;170;171;165;164;164;165 19:22:21 INFO - PID 10611 | |3;audio-fft;75;75;78;106;87;76;76;75;93;78 19:22:21 INFO - PID 10611 | |4;audio-oscillator;85;84;110;85;84;84;103;87;85;101 19:22:21 INFO - PID 10611 | |5;imaging-gaussian-blur;117;114;113;114;113;116;115;114;116;114 19:22:21 INFO - PID 10611 | |6;imaging-darkroom;149;150;152;151;151;150;151;150;151;151 19:22:21 INFO - PID 10611 | |7;imaging-desaturate;95;95;95;94;94;96;94;94;95;94 19:22:21 INFO - PID 10611 | |8;json-parse-financial;68;68;67;68;69;69;67;68;68;68 19:22:21 INFO - PID 10611 | |9;json-stringify-tinderbox;56;55;54;58;56;56;56;56;56;55 19:22:21 INFO - PID 10611 | |10;stanford-crypto-aes;84;85;82;84;84;92;82;84;83;83 19:22:21 INFO - PID 10611 | |11;stanford-crypto-ccm;144;137;134;138;136;150;154;149;218;135 19:22:21 INFO - PID 10611 | |12;stanford-crypto-pbkdf2;189;194;198;198;194;209;208;193;203;196 19:22:21 INFO - PID 10611 | |13;stanford-crypto-sha256-iterative;72;72;73;72;74;72;70;71;71;69 19:22:21 INFO - PID 10611 | __end_tp_report 19:22:21 INFO - PID 10611 | __start_cc_report 19:22:21 INFO - PID 10611 | _x_x_mozilla_cycle_collect,863 19:22:21 INFO - PID 10611 | __end_cc_report 19:22:21 INFO - PID 10611 | __startTimestamp1490322141639__endTimestamp 19:22:21 INFO - PID 10611 | 19:22:21 INFO - PID 10611 | ------- Summary: start ------- 19:22:21 INFO - PID 10611 | Number of tests: 14 19:22:21 INFO - PID 10611 | 19:22:21 INFO - PID 10611 | [#0] ai-astar Cycles:10 Average:111.10 Median:112.00 stddev:3.07 (2.7%) stddev-sans-first:1.22 19:22:21 INFO - PID 10611 | Values: 103.0 113.0 113.0 111.0 112.0 114.0 112.0 112.0 110.0 111.0 19:22:21 INFO - PID 10611 | 19:22:21 INFO - PID 10611 | [#1] audio-beat-detection Cycles:10 Average:136.50 Median:128.50 stddev:17.25 (13.4%) stddev-sans-first:17.10 19:22:21 INFO - PID 10611 | Values: 154.0 128.0 129.0 174.0 125.0 125.0 127.0 125.0 152.0 126.0 19:22:21 INFO - PID 10611 | 19:22:21 INFO - PID 10611 | [#2] audio-dft Cycles:10 Average:166.30 Median:165.50 stddev:2.67 (1.6%) stddev-sans-first:2.70 19:22:21 INFO - PID 10611 | Values: 164.0 166.0 165.0 169.0 170.0 171.0 165.0 164.0 164.0 165.0 19:22:21 INFO - PID 10611 | 19:22:21 INFO - PID 10611 | [#3] audio-fft Cycles:10 Average:81.90 Median:77.00 stddev:10.40 (13.5%) stddev-sans-first:10.72 19:22:21 INFO - PID 10611 | Values: 75.0 75.0 78.0 106.0 87.0 76.0 76.0 75.0 93.0 78.0 19:22:21 INFO - PID 10611 | 19:22:21 INFO - PID 10611 | [#4] audio-oscillator Cycles:10 Average:90.80 Median:84.50 stddev:9.86 (11.7%) stddev-sans-first:10.24 19:22:21 INFO - PID 10611 | Values: 85.0 84.0 110.0 85.0 84.0 84.0 103.0 87.0 85.0 101.0 19:22:21 INFO - PID 10611 | 19:22:21 INFO - PID 10611 | [#5] imaging-gaussian-blur Cycles:10 Average:114.60 Median:114.50 stddev:1.35 (1.2%) stddev-sans-first:1.12 19:22:21 INFO - PID 10611 | Values: 117.0 114.0 113.0 114.0 113.0 116.0 115.0 114.0 116.0 114.0 19:22:21 INFO - PID 10611 | 19:22:21 INFO - PID 10611 | [#6] imaging-darkroom Cycles:10 Average:150.60 Median:151.00 stddev:0.84 (0.6%) stddev-sans-first:0.67 19:22:21 INFO - PID 10611 | Values: 149.0 150.0 152.0 151.0 151.0 150.0 151.0 150.0 151.0 151.0 19:22:21 INFO - PID 10611 | 19:22:21 INFO - PID 10611 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 19:22:21 INFO - PID 10611 | Values: 95.0 95.0 95.0 94.0 94.0 96.0 94.0 94.0 95.0 94.0 19:22:21 INFO - PID 10611 | 19:22:21 INFO - PID 10611 | [#8] json-parse-financial Cycles:10 Average:68.00 Median:68.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 19:22:21 INFO - PID 10611 | Values: 68.0 68.0 67.0 68.0 69.0 69.0 67.0 68.0 68.0 68.0 19:22:21 INFO - PID 10611 | 19:22:21 INFO - PID 10611 | [#9] json-stringify-tinderbox Cycles:10 Average:55.80 Median:56.00 stddev:1.03 (1.8%) stddev-sans-first:1.09 19:22:21 INFO - PID 10611 | Values: 56.0 55.0 54.0 58.0 56.0 56.0 56.0 56.0 56.0 55.0 19:22:21 INFO - PID 10611 | 19:22:21 INFO - PID 10611 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:84.00 stddev:2.87 (3.4%) stddev-sans-first:3.04 19:22:21 INFO - PID 10611 | Values: 84.0 85.0 82.0 84.0 84.0 92.0 82.0 84.0 83.0 83.0 19:22:21 INFO - PID 10611 | 19:22:21 INFO - PID 10611 | [#11] stanford-crypto-ccm Cycles:10 Average:149.50 Median:146.50 stddev:25.09 (17.1%) stddev-sans-first:26.53 19:22:21 INFO - PID 10611 | Values: 144.0 137.0 134.0 138.0 136.0 150.0 154.0 149.0 218.0 135.0 19:22:21 INFO - PID 10611 | 19:22:21 INFO - PID 10611 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:198.20 Median:198.00 stddev:6.56 (3.3%) stddev-sans-first:6.06 19:22:21 INFO - PID 10611 | Values: 189.0 194.0 198.0 198.0 194.0 209.0 208.0 193.0 203.0 196.0 19:22:21 INFO - PID 10611 | 19:22:21 INFO - PID 10611 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.60 Median:72.00 stddev:1.43 (2.0%) stddev-sans-first:1.51 19:22:21 INFO - PID 10611 | Values: 72.0 72.0 73.0 72.0 74.0 72.0 70.0 71.0 71.0 69.0 19:22:21 INFO - PID 10611 | -------- Summary: end -------- 19:22:21 INFO - PID 10611 | 19:22:22 INFO - TEST-INFO | 10611: exit 0 19:22:22 INFO - TEST-OK | kraken | took 65277ms 19:22:22 INFO - SUITE-END | took 1186s 19:22:23 INFO - Completed test suite (00:19:46) 19:22:23 INFO - javascript benchmark 19:22:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6471.30114689909, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2663.17441593106, 2674.807819896939, 2690.5157071727094, 2699.7300269973007, 2718.6193932849405, 5037.992401519692, 5070.13807652699, 5087.4149472810595, 5162.045021670984, 5186.74066296685, 5064.215046667772, 5163.432022477525, 5169.715665638389, 5232.110541207994, 5235.816746413876, 4659.790309436084, 4664.906701865961, 4683.578477936985, 4689.2966055091665, 4714.080754252922, 4728.243481043034, 4756.7383793891495, 4757.286407038937, 4776.259679749644, 4812.398450193726, 4690.1557719610455, 4694.225452800284, 4699.553542413465, 4721.197396442579, 4726.5746082852365, 4716.693414928019, 4720.079584481027, 4734.053189362141, 4748.833790817339, 4768.094062128184, 4622.399088118556, 4655.837045703418, 4676.041411510632, 4705.670603057787, 4726.338312636233, 4937.0, 4938.851834444937, 4991.575716064139, 4991.725455099968, 5144.099782538041, 5426.75579598915, 5428.321459817523, 5429.837104886859, 5431.701256430894, 5433.592480563934, 5447.264619276387, 5480.972595137038, 5490.780368785244, 5492.231087647732, 5494.395616482184, 5031.245313203049, 5095.796168153232, 5096.668716533413, 5101.20931255656, 5106.514881086291, 5591.776328946797, 5597.720113994284, 5599.216109744639, 5601.215829783833, 5601.747921343549, 5324.627276090714, 5444.428335024844, 5477.04151773438, 5516.834494965157, 5532.031894418461, 5570.97214513933, 5592.888142237132, 5601.60788744784, 5603.971980140154, 5641.26663533738, 5536.086545719912, 5553.111502159635, 5553.4724201200825, 5555.9721451531595, 5566.304211973504, 5354.170103633943, 5415.5938304626525, 5506.0, 5543.113101903757, 5611.8597035073635, 4562.8631141065825, 4576.130535198302, 4594.977025114853, 4605.332226827091, 4609.377734005866, 3944.546377166605, 3949.940750888739, 3983.3626619740703, 3990.4812374391145, 4003.3794761811964, 4702.036082603058, 4754.762261886961, 4778.738999276965, 4819.807207711722, 4819.831305904277, 5569.749361278752, 5593.608447408724, 5595.328560572757, 5604.971975140098, 5619.409961953936, 4836.613070954315, 4845.6608037437745, 4855.223164293696, 4856.247281671346, 4892.926606100911, 4797.136515427256, 4840.636952228527, 4965.950340496621, 4966.751662416865, 4981.601471882241, 5080.288759573588, 5081.136206844772, 5082.847514574569, 5083.389993200692, 5087.109755792795, 5367.570594352521, 5405.675659460445, 5412.594055445778, 5418.566514678895, 5429.511343979061, 5214.608904332114, 5233.215017747369, 5237.528622424, 5277.182036784305, 5280.706226974416, 5422.891542169214, 5459.481349271813, 5486.753096110605, 5497.065498865282, 5497.092979658311, 5436.483534064258, 5569.777208911761, 5573.359063707726, 5585.245991791056, 5630.23991761107, 5308.708021058879, 5430.456954304538, 5437.4018857926385, 5476.534494568006, 5482.80810171642, 5411.78352865881, 5448.427915069019, 5465.0, 5467.4532546745, 5473.0969390050195, 5327.493888080626, 5339.439358867418, 5397.325334333208, 5400.0, 5439.673619582838, 5324.946750532445, 5356.973215134055, 5359.437259087896, 5359.866003349947, 5369.006733754268, 5310.0, 5338.57291416678, 5355.196720491957, 5373.919391209213, 5384.6769193848495], "value": 5040.668728551171, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.8551231598892, 611.2084850119096, 625.5402279324697, 1162.895339419452, 1190.7499425120725, 32293.0, 32819.17952051197, 33059.173520661934, 33125.0, 33183.66816331836, 30359.696403035963, 30730.846345768296, 30830.0, 30876.38247235054, 30884.84557577209, 6800.659967001642, 7140.714371425162, 7290.161631412376, 7294.197638259787, 7301.817454563626, 7406.7777966660815, 7413.369863561604, 7440.888386674204, 7487.513311634753, 7511.849763004737, 7461.664225109856, 7520.736774212904, 7530.58581778002, 7533.133689625708, 7544.4718869679145, 7408.703651853919, 7489.363404110684, 7512.361449276818, 7638.083429988437, 7668.041494813148, 7344.192138864721, 7394.112706475204, 7395.149557800868, 7402.259774022555, 7405.444591655593, 32936.3412731744, 33270.50094248588, 33274.168145796546, 33416.49875251873, 33462.0, 2632.670916135483, 2647.7749391301763, 2663.2409763217584, 2668.6397336359732, 2686.2344231893817, 23588.29235122932, 23690.881545592336, 24018.51962960731, 24228.304018718696, 24887.875560622262, 2631.8289311194903, 2653.6948250951195, 2654.8539830309323, 2655.322892662378, 2682.088090049373, 112687.43656281749, 113435.0, 154841.0, 155199.0, 155417.0, 39334.213315734094, 40183.59357422476, 40246.79876600598, 40362.59637403647, 40432.0, 42459.0, 42521.57478425238, 42550.57449425466, 42578.36132458015, 42712.0, 11283.830742538868, 11386.94306528462, 11461.369624670722, 11502.137339699557, 11502.194846360842, 9154.954225228965, 9172.44965302084, 9176.220021298264, 9177.678781242757, 9194.264458843276, 12557.372131393393, 12652.683682908, 12660.430280637393, 12736.872631273754, 12790.0, 5205.5315021647475, 5312.92030619541, 5359.651622644516, 5405.081136206775, 5471.534919531805, 856.6573370651664, 857.2970164465204, 874.7026011156238, 884.681824082113, 897.4301318662697, 20632.489056124996, 21478.57042859134, 21689.67465488019, 21706.240281590068, 21753.564928701653, 938.4979036215728, 948.2650945517279, 950.6577632052456, 963.0754475703263, 966.6906589891308, 10720.731981700364, 11302.604408845651, 11319.830202546967, 11327.0, 11515.654530364103, 223801.0, 224932.0, 226059.0, 226286.0, 226348.0, 43809.56190438118, 43948.12103757907, 44233.778831105636, 44271.557284427385, 44439.55560444419, 1181.468339247342, 1204.7891618966646, 1214.9271043737403, 1224.5958833584896, 1228.9385530723607, 19955.401337959884, 19962.30131945375, 21033.89483052575, 21169.57660846805, 21459.78540214578, 31264.0, 31358.05925822229, 31364.215894602818, 31552.368952621277, 31634.841825790725, 208712.0, 209017.0, 209477.0, 209765.0, 210516.0, 27490.587641184997, 28032.159035228975, 28052.85973570119, 28077.034607577272, 28724.0, 32736.34527309488, 32953.34093318168, 33214.0, 33975.0, 34042.489362659086, 25696.357591059626, 26256.21231363062, 27432.45135097247, 27696.861515692293, 28723.425531488836, 27689.0, 27708.168754937386, 27759.722402776522, 27857.58213626838, 28821.85589072125, 29883.252918677208, 30773.692263077977, 30847.537286941162, 30882.227944301572, 30995.225119371295, 26933.730662693906, 27204.45591088207, 27230.455390892468, 27637.861810690818, 28291.0, 20945.685814712488, 22145.11419543265, 22301.553968920205, 22514.437139071, 22540.887295563418], "value": 14578.88113983265, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [409.4472462176061, 413.8386029448516, 423.8770756480621, 426.31363504757337, 441.9315006174042, 14913.701725965475, 17648.47054588361, 17972.55068623285, 18316.900985940854, 18317.267309307645, 16113.27490262938, 16332.510024699248, 16354.0, 16408.09755463449, 16584.50246492604, 5613.550915926716, 5637.943620563793, 5729.684867332295, 5875.911861322063, 5880.5883588148845, 5703.429657034305, 5747.885042299152, 5770.855728606776, 5791.565632577553, 5806.564507661921, 5519.724013799314, 5640.210370548127, 5688.0, 5729.627574207684, 5759.0, 5707.400722924095, 5735.741891614845, 5762.538996880239, 5768.711564421762, 5775.826725198251, 4971.27916452116, 5136.280920671109, 5169.819056333048, 5188.584913206934, 5191.351081114861, 21732.565348693097, 21844.781552184435, 21859.453513662127, 21879.781202187933, 22122.557548848934, 1493.9925300373536, 1499.0705762427256, 1504.210289597959, 1527.6333679916852, 1539.7151526967434, 13414.0, 13615.183089014592, 13780.517681881087, 14249.073810202408, 14278.071925324924, 1608.921933085502, 1629.2179753718162, 1697.6095498035397, 1703.880728349016, 1751.2382113780545, 75408.24591754067, 77146.61426692887, 77200.22799771986, 86452.0, 89968.55015724945, 10890.782184356427, 10991.120710343313, 11069.446527673745, 11148.777024459465, 11318.660440186808, 13418.865811341957, 15674.9216253918, 15695.058296502246, 15703.607409814846, 15710.607234819221, 6618.437432818168, 6836.316368363224, 7118.572885626879, 7119.038929744522, 7158.2483839197175, 6209.285932117774, 6333.651649159248, 6397.136386587844, 6526.836829079216, 6545.770898018546, 7028.578285302899, 7041.260667629927, 7100.112485939258, 7143.63336395871, 7253.347198752032, 2111.2082968886666, 2116.8200702940117, 2131.563029578964, 2135.8504904656834, 2210.1159536185655, 825.6037102190982, 849.4987957105214, 882.571952602987, 884.2616415293173, 905.5970093308546, 16510.917445412695, 17031.233594488276, 17064.829351706325, 17318.047507387215, 17415.91292043557, 874.9868751968726, 877.6664867350366, 882.6513527156866, 902.7291812456236, 908.8545832666741, 8984.416012959136, 9643.180329671915, 9681.419114853132, 9685.854712179324, 9703.563339649732, 418522.0, 419647.0, 420095.0, 443366.0, 449214.0, 87074.0, 88353.0, 88477.0, 88743.0, 88804.555977221, 1065.6217042949797, 1070.6895000449783, 1077.5258886090096, 1098.0501865885951, 1157.35188294557, 16543.917280414003, 16888.66222675564, 17348.219330130425, 17886.910565447088, 18161.909190453964, 41193.0, 41628.0, 42072.36891446692, 42335.36496952487, 42532.1493570133, 52747.20879186892, 52903.20645190248, 53352.0, 55386.72306638441, 55501.44498554963, 7708.807279818049, 7751.844963100819, 7829.373650108091, 7855.057393112863, 8188.05837328691, 11570.421478926188, 11852.0, 12009.159358844798, 12132.0, 12147.33189674541, 9879.0, 10003.249756268455, 10213.285070045322, 10366.170706343324, 10399.32404393712, 9431.481268530297, 9827.11555959967, 9998.900011000087, 10023.899761002296, 10161.847572286273, 9788.168005719594, 10166.288359814742, 10281.794364112826, 10331.483425828528, 10603.89396106029, 7395.482316238027, 7469.215732348025, 7546.434017448603, 7702.537847729154, 7802.804929876572, 9761.0, 9912.504374781089, 10106.747331316481, 10275.280730348804, 10361.356932153369], "value": 8724.365965291745, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1229.1396022784052, 1289.5679947217682, 1318.5714642741107, 1319.3535167767798, 1323.3317174826711, 9274.953625231872, 9663.565139568718, 9764.023597640242, 9775.902240977588, 10013.299069065168, 9696.0, 9838.508074596259, 9839.360441571293, 9849.852252216222, 9878.901210987888, 2131.2114517628497, 2144.2066435418915, 2159.1039718516877, 2160.4274867160216, 2168.9783102168935, 2092.5082605587677, 2110.873347599149, 2117.311873641065, 2174.521605246843, 2178.21584229678, 2115.471132216946, 2149.924752633658, 2208.7018252535945, 2224.3882932193696, 2225.2100504320974, 2127.755308139568, 2130.8508404411696, 2134.423705599487, 2137.690034944932, 2141.7858214178614, 1780.4035648057786, 1845.5570663040908, 2017.122551690005, 2082.4481512399225, 2125.192426877792, 9764.951175244149, 9831.754206144831, 9890.30767846251, 9904.207663386911, 9923.561083642904, 4996.400431948153, 5143.639945203838, 5183.067047931371, 5186.299849520342, 5189.273501709764, 3059.1587313488744, 3084.383123375334, 3127.5934128563367, 3141.575887255214, 3222.3555288942307, 987.4322264697828, 998.8651532043226, 1002.2382988928395, 1007.9244056695704, 1022.6420752736483, 13596.728065438734, 13700.52048178319, 13781.931090344584, 13840.9999999999, 13878.375473103633, 4841.05599408112, 4915.16442204826, 4988.301637770715, 5075.56857667095, 5111.616628752859, 11920.940395297968, 12016.339101349335, 12032.217905836093, 12035.699107522381, 12059.095567832448, 5334.413214546396, 5358.276632654542, 5359.08895487768, 5370.462953704677, 5386.0, 4630.282306242538, 4684.6486513510945, 4732.905341893143, 4790.4969978152485, 4809.302651115569, 3914.9021274467796, 4074.409210664437, 4078.2659121357847, 4115.773632450184, 4119.340905455173, 1275.79587266037, 1281.641140480667, 1294.5922034559085, 1311.6917524381763, 1320.2078752748466, 670.607694498714, 694.0768777525878, 696.4150113904243, 700.7687463137153, 710.9786706398817, 5223.4776522347465, 5232.2674825524455, 5327.413984461784, 5350.1439769637445, 5429.049916264717, 541.1179776963525, 553.3857418265721, 553.7037684838592, 557.882844602638, 568.4713216708501, 3406.9659303407143, 3497.597776255763, 3547.077759782475, 3596.622354652724, 3675.4119340905327, 11361.602343917923, 11733.35466549348, 12133.15067945253, 12335.50657973671, 12535.686607834694, 12151.696207594881, 12506.124571279923, 12512.624621261377, 12713.42789574453, 12812.743745125046, 9205.631774728936, 9218.308626853013, 9237.584308706124, 9329.16037556623, 9338.112879276458, 6191.380861913953, 6337.112804207322, 6341.651209183355, 6427.1002059710745, 6517.217933847779, 11616.88383116158, 11628.418579071182, 11646.301221926373, 11833.171677982458, 11925.403729813648, 11848.585299514476, 11897.643070707893, 11963.700907477383, 11988.400579970792, 12192.963598094262, 8066.112727600077, 8232.794180145544, 8278.213569710868, 8283.875741863998, 8292.419530632798, 9255.86116208244, 9282.303827213122, 9339.20616747584, 9356.81286374255, 9412.717618471457, 7505.699772009277, 7621.12357078943, 7623.65693543803, 7638.770836874903, 7644.770656880302, 7557.735479258199, 7622.885656715042, 7641.694332226649, 7668.961655191688, 7840.490368126054, 7057.858842823218, 7069.858602828018, 7076.575405475688, 7109.75115870942, 7185.461090418135, 4738.360321356573, 4763.261694437368, 5214.5567626750635, 5344.9732751336, 5373.731313434391, 4848.684835485682, 4925.359703238556, 4969.47820478859, 5006.0, 5031.345925029723], "value": 4589.424411666156, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.1647211413749, 389.6415297925908, 389.85965052581065, 392.56033242768103, 400.9398590211468, 5590.385057643661, 5627.385543854031, 5659.122835960427, 5671.262735844345, 5718.428157184279, 5551.8889622207635, 5561.721913904309, 5566.997940370732, 5573.665580065199, 5588.524975377098, 4032.254033003889, 4222.788860556975, 4287.9356809647725, 4288.635465985395, 4447.733136011833, 4269.935950960738, 4270.530241673413, 4275.40144379787, 4282.828686852522, 4294.849680261192, 4258.339957306623, 4258.659307255428, 4263.360495925605, 4267.14657068586, 4270.252705776492, 4153.937690934608, 4220.451341325608, 4248.87253382399, 4267.530571637133, 4273.572642735733, 3669.7064234861145, 3686.3548878946344, 3686.8156592170285, 3693.501377314055, 3695.1870588470492, 5386.569074474072, 5395.165643681128, 5399.298091248152, 5418.320320700595, 5449.3188351456065, 4768.928466073012, 4871.391076115486, 4918.803247870081, 4930.359053323045, 4936.901261974776, 5832.1834943108, 5854.385289544579, 5859.794907178229, 5870.148828419898, 5879.67661778602, 4048.3725022621543, 4074.388841673743, 4078.5717499662405, 4079.1229885574744, 4087.7751723655188, 5874.9118763218585, 6065.909011364833, 6196.318404975449, 6241.875162496724, 6284.2458904931245, 4189.141226048653, 4193.329067349209, 4199.832006719758, 4202.474690663667, 4208.957910420918, 4220.409142720022, 4230.534641189467, 4236.851710190129, 4265.573442655772, 4277.914441711148, 4780.211265141283, 4839.0, 4861.319415281863, 4878.634102442331, 4886.780094895738, 5828.154917536934, 5840.415958404125, 5841.591088623755, 5859.53123750099, 5873.970630146822, 1457.679310551677, 1463.6121427821636, 1467.7064587082625, 1471.1981969826256, 1472.5950363649868, 932.2167799020388, 975.7853272280087, 977.9902200978041, 979.8187335342984, 988.545269176187, 5132.8460146195675, 5139.563137133386, 5146.768395422215, 5147.227915812583, 5147.271945868695, 6083.72241829212, 6083.958020989505, 6093.055576385667, 6098.603590766586, 6101.725422355916, 4923.286123512071, 5093.0, 5133.204353325241, 5156.9742151289, 5165.483451654804, 3208.4385232584204, 3229.5963004624423, 3246.1397729601676, 3263.249452625862, 3268.9019329420157, 5541.7303790762835, 5711.8000869969355, 5714.571407144481, 5727.455891690282, 5728.885422291531, 6248.75004999804, 6270.3416141305415, 6332.335104813928, 6336.493080553545, 6357.904631430532, 5693.405846363025, 5697.544196464356, 5698.715064246854, 5703.9429605704245, 5705.800296989585, 5954.821355359346, 6047.09293605945, 6086.847828804138, 6106.1451396803595, 6108.0, 5997.670128142994, 6010.819675409744, 6018.398160183947, 6025.276966764016, 6033.396660333931, 5379.704116273642, 5479.123340265538, 5541.3904470507405, 5630.155476678531, 5644.774209031592, 4169.749815011109, 4177.436046133855, 4185.22573323936, 4211.0, 4211.0946146578635, 5968.166449415482, 6119.694015299128, 6125.632462052291, 6128.601640893506, 6133.110698948538, 5889.469947704727, 5911.054231322968, 5913.476190714193, 5919.704014799329, 5923.600941618652, 5886.793962211302, 5889.234399528034, 5892.94107058924, 5895.174675545341, 5943.138244954544, 5572.3034620672415, 5740.311162660508, 5783.913241301468, 5871.4715675589405, 5874.735636896436, 5954.136650185786, 5958.080540535193, 5983.282006159288, 6013.248343957005, 6047.274327080779, 5673.290838645169, 5783.0, 5871.1486834409625, 5896.469317761422, 5908.527317814651], "value": 4409.742856314377, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.464745462992, 603.5955909540606, 610.6549799363362, 619.0343064818883, 636.0237036149512, 10502.369857808528, 11163.944180279097, 11166.776664466715, 11192.44037798111, 11196.440177991108, 10682.572697092126, 11262.662120136389, 11388.08895288377, 11493.482793274301, 11513.078953683706, 792.1128336263394, 794.3208556684039, 804.6379129391768, 807.90709068457, 824.4393812207696, 817.6647574494458, 822.1039067416515, 826.7519744076783, 827.028241815867, 828.6229765456703, 864.2049314630524, 865.9567021648924, 866.5320726807516, 867.7049803066956, 868.1492137705021, 860.096898256834, 861.332467337812, 861.9138086191393, 862.1421685423044, 862.9395942284043, 635.4154178156061, 637.2416823979496, 637.3785559079906, 638.565775272819, 639.3350915048344, 12668.619941401772, 12887.613371598867, 12971.221726696429, 12980.350982450935, 13083.934580327134, 13541.187528748307, 14051.20294578652, 14110.576682699535, 14321.928390358085, 14370.768211326587, 8838.911610883937, 8904.6197839335, 9071.365004449692, 9160.954195229047, 9522.285828562815, 2342.9179978700663, 2378.5242951409787, 2409.8072154227793, 2448.9387765305833, 2460.3849037740565, 67433.0, 68642.65678671574, 69220.0, 69967.3003269971, 70244.64877675578, 9571.234301255883, 9661.372010819274, 9719.465429401309, 9780.853287200698, 9971.202303815677, 18806.435806925812, 18839.24643014264, 18854.52863678419, 18991.90504047471, 18998.81001189998, 5585.609007369445, 5639.661620302795, 5684.801031963944, 5820.039693450618, 5846.561507886926, 3065.325628361757, 3067.7239048485744, 3111.7199452049426, 3114.486109791859, 3115.4703700370537, 3164.4620414529127, 3706.703463722896, 3859.6333348331864, 3860.4595356650093, 3864.2464719380014, 699.2483080688179, 702.7294491620763, 704.2745971649209, 714.1608609883366, 726.6185252742353, 486.8977514721948, 496.3919198981219, 501.3282201849539, 504.1731560241207, 511.56516960583207, 7465.29079737424, 7884.211578842184, 8206.876896846552, 8403.000214872141, 8654.264387527004, 485.2071595454761, 493.47198497607934, 503.7531609511313, 516.2694786876602, 521.1843464977298, 3496.650334966534, 3516.2088530080528, 3597.6042635310096, 3676.3198808220563, 3704.4628528863163, 53326.73336633292, 55577.722111389994, 56465.0, 57718.7114064427, 57916.131258031164, 51404.48595514072, 51853.7407312961, 51906.0, 52478.737606311726, 52590.73704631453, 45810.312845307344, 45917.77041114773, 46868.53131468778, 47334.52665473301, 47993.0, 7146.392556632536, 7417.851642967218, 7441.4046876248685, 7556.924430755622, 7606.771796846104, 23838.0, 24095.156669516484, 24206.394840129138, 24496.632550512113, 24856.130035448674, 29929.401411972074, 30197.547036794025, 30511.0, 30902.53646195354, 31491.527627085154, 8947.776305592412, 8955.59699813497, 9018.458892466473, 9159.267258619162, 9369.672061477815, 9956.103950644478, 10022.3485473444, 10180.134688551556, 10190.388576685422, 10573.154147668321, 9071.90928090737, 9378.202852757591, 9567.0, 9579.23366130694, 9948.651797187063, 9114.726558203265, 9138.68014619485, 9274.675386361445, 9635.710928672152, 9739.610415583298, 8452.112528184452, 8669.6098675561, 8689.695860644848, 9088.636454541744, 9090.0, 6841.21326047491, 6852.725890964306, 6964.721411143498, 6991.091158149408, 7120.394766444703, 7666.0, 7738.187490313436, 7962.641681124247, 8017.679292828221, 8095.23095305945], "value": 5659.773471726772, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1573.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 113.0, 111.0, 112.0, 114.0, 112.0, 112.0, 110.0, 111.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 128.0, 129.0, 174.0, 125.0, 125.0, 127.0, 125.0, 152.0, 126.0], "value": 136.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 166.0, 165.0, 169.0, 170.0, 171.0, 165.0, 164.0, 164.0, 165.0], "value": 166.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 78.0, 106.0, 87.0, 76.0, 76.0, 75.0, 93.0, 78.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 110.0, 85.0, 84.0, 84.0, 103.0, 87.0, 85.0, 101.0], "value": 90.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 114.0, 113.0, 114.0, 113.0, 116.0, 115.0, 114.0, 116.0, 114.0], "value": 114.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 152.0, 151.0, 151.0, 150.0, 151.0, 150.0, 151.0, 151.0], "value": 150.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 94.0, 96.0, 94.0, 94.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 67.0, 68.0, 69.0, 69.0, 67.0, 68.0, 68.0, 68.0], "value": 68.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 54.0, 58.0, 56.0, 56.0, 56.0, 56.0, 56.0, 55.0], "value": 55.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 82.0, 84.0, 84.0, 92.0, 82.0, 84.0, 83.0, 83.0], "value": 84.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 137.0, 134.0, 138.0, 136.0, 150.0, 154.0, 149.0, 218.0, 135.0], "value": 149.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 194.0, 198.0, 198.0, 194.0, 209.0, 208.0, 193.0, 203.0, 196.0], "value": 198.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 73.0, 72.0, 74.0, 72.0, 70.0, 71.0, 71.0, 69.0], "value": 71.6, "unit": "score"}]}]} 19:22:23 INFO - Return code: 0 19:22:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:22:23 ERROR - # TBPL SUCCESS # 19:22:23 INFO - Running post-action listener: _resource_record_post_action 19:22:23 INFO - [mozharness: 2017-03-24 02:22:23.435641Z] Finished run-tests step (success) 19:22:23 INFO - Running post-run listener: _resource_record_post_run 19:22:23 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 377729024; Read time: 16; Write time: 342420 19:22:23 INFO - TinderboxPrint: CPU usage
13.3% 19:22:23 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 19:22:23 INFO - TinderboxPrint: I/O write bytes / time
377,729,024 / 342,420 19:22:23 INFO - TinderboxPrint: CPU idle
8,322.3 (86.7%) 19:22:23 INFO - TinderboxPrint: CPU user
1,220.1 (12.7%) 19:22:23 INFO - TinderboxPrint: Swap in / out
0 / 0 19:22:23 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 118898688; Read time: 0; Write time: 101060 19:22:23 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 258830336; Read time: 16; Write time: 241360 19:22:24 INFO - Running post-run listener: _upload_blobber_files 19:22:24 INFO - Blob upload gear active. 19:22:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:22:24 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 19:22:24 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', 'Pine', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:22:24 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 Pine -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:22:24 INFO - (blobuploader) - INFO - Open directory for files ... 19:22:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:22:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:22:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:22:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:22:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:22:28 INFO - (blobuploader) - INFO - Done attempting. 19:22:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:22:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:22:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:22:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:22:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:22:28 INFO - (blobuploader) - INFO - Done attempting. 19:22:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:22:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:22:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:22:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:22:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:22:29 INFO - (blobuploader) - INFO - Done attempting. 19:22:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:22:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:22:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:22:30 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:22:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:22:30 INFO - (blobuploader) - INFO - Done attempting. 19:22:30 INFO - (blobuploader) - INFO - Iteration through files over. 19:22:30 INFO - Return code: 0 19:22:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:22:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:22:30 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/511eea1768c44f67ae1dad91124c4154b2d80250f7b9f6e1942edbf50bc57f04b5efa521c4cce57bb04115a34b27226ebc5e773a614d66d33ab71e37d1e2cf9a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/beaef0323daf6824659924a3dbeffb424d782eea4221994044b9f6f9f5bca231e3ddc8265462a4ac076bd4a0dab542ea7df0a3c6620d1db36a23c0928a282aa8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/6ec5556c1956f4af7424d347de6d2db1717a9ac417a446876f541172c864e13967b63c37748b95d37a9c38909fb514b5a5b71f52ede96647af5267f164c9d951", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/bc896cfa7b98bbea37a1e52045b4e79097e66b222a1c1bb026ebc452c152f2f07bda1604c45841b1932e1dcb7a59cbaac2f54652a6ddaa1cbc962303a945cef0"} 19:22:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:22:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:22:30 INFO - Contents: 19:22:30 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/511eea1768c44f67ae1dad91124c4154b2d80250f7b9f6e1942edbf50bc57f04b5efa521c4cce57bb04115a34b27226ebc5e773a614d66d33ab71e37d1e2cf9a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/beaef0323daf6824659924a3dbeffb424d782eea4221994044b9f6f9f5bca231e3ddc8265462a4ac076bd4a0dab542ea7df0a3c6620d1db36a23c0928a282aa8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/6ec5556c1956f4af7424d347de6d2db1717a9ac417a446876f541172c864e13967b63c37748b95d37a9c38909fb514b5a5b71f52ede96647af5267f164c9d951", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/bc896cfa7b98bbea37a1e52045b4e79097e66b222a1c1bb026ebc452c152f2f07bda1604c45841b1932e1dcb7a59cbaac2f54652a6ddaa1cbc962303a945cef0"} 19:22:30 INFO - Running post-run listener: copy_logs_to_upload_dir 19:22:30 INFO - Copying logs to upload dir... 19:22:30 INFO - mkdir: /builds/slave/test/build/upload/logs 19:22:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.170614 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-03-23 19:22:30.559640) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-23 19:22:30.563055) ========= 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=3836458cccd887f2d2de3cf1000001de-1490320885.753994-1075068045 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/511eea1768c44f67ae1dad91124c4154b2d80250f7b9f6e1942edbf50bc57f04b5efa521c4cce57bb04115a34b27226ebc5e773a614d66d33ab71e37d1e2cf9a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/beaef0323daf6824659924a3dbeffb424d782eea4221994044b9f6f9f5bca231e3ddc8265462a4ac076bd4a0dab542ea7df0a3c6620d1db36a23c0928a282aa8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/6ec5556c1956f4af7424d347de6d2db1717a9ac417a446876f541172c864e13967b63c37748b95d37a9c38909fb514b5a5b71f52ede96647af5267f164c9d951", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/bc896cfa7b98bbea37a1e52045b4e79097e66b222a1c1bb026ebc452c152f2f07bda1604c45841b1932e1dcb7a59cbaac2f54652a6ddaa1cbc962303a945cef0"} build_url:https://queue.taskcluster.net/v1/task/BB5OsR0cSquSGZobh5SR5g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011290 build_url: 'https://queue.taskcluster.net/v1/task/BB5OsR0cSquSGZobh5SR5g/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/511eea1768c44f67ae1dad91124c4154b2d80250f7b9f6e1942edbf50bc57f04b5efa521c4cce57bb04115a34b27226ebc5e773a614d66d33ab71e37d1e2cf9a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/beaef0323daf6824659924a3dbeffb424d782eea4221994044b9f6f9f5bca231e3ddc8265462a4ac076bd4a0dab542ea7df0a3c6620d1db36a23c0928a282aa8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/6ec5556c1956f4af7424d347de6d2db1717a9ac417a446876f541172c864e13967b63c37748b95d37a9c38909fb514b5a5b71f52ede96647af5267f164c9d951", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/bc896cfa7b98bbea37a1e52045b4e79097e66b222a1c1bb026ebc452c152f2f07bda1604c45841b1932e1dcb7a59cbaac2f54652a6ddaa1cbc962303a945cef0"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-23 19:22:30.589297) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 19:22:30.589674) ========= 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=3836458cccd887f2d2de3cf1000001de-1490320885.753994-1075068045 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004368 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 19:22:30.672496) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-23 19:22:30.672847) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-23 19:22:30.673169) ========= ========= Total master_lag: 0.18 =========