builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-026 starttime: 1493992347.92 results: success (0) revision: 9348b76977e833f108cf77dff75b0fab887a2fc1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-05 06:52:27.918075) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-05 06:52:27.918516) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-05 06:52:27.918790) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-05 06:52:27.933722) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 06:52:27.934014) ========= 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=41bf3e9aed84707956354da8000001c5-1493992225.467577-93714130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-05 06:52:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 50.3M=0s 2017-05-05 06:52:28 (50.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.121007 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 06:52:28.069726) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 06:52:28.070048) ========= 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=41bf3e9aed84707956354da8000001c5-1493992225.467577-93714130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014488 ========= master_lag: 0.15 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 06:52:28.230265) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-05 06:52:28.234608) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9348b76977e833f108cf77dff75b0fab887a2fc1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 9348b76977e833f108cf77dff75b0fab887a2fc1 --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=41bf3e9aed84707956354da8000001c5-1493992225.467577-93714130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-05 06:52:28,991 truncating revision to first 12 chars 2017-05-05 06:52:28,991 Setting DEBUG logging. 2017-05-05 06:52:28,991 attempt 1/10 2017-05-05 06:52:28,991 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9348b76977e8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-05 06:52:29,471 unpacking tar archive at: mozilla-central-9348b76977e8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.169842 ========= master_lag: 0.66 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-05 06:52:30.062512) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-05 06:52:30.062829) ========= script_repo_revision: 9348b76977e833f108cf77dff75b0fab887a2fc1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-05 06:52:30.063216) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-05 06:52:30.068579) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-05 06:52:30.082123) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-05-05 06:52:30.082502) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=41bf3e9aed84707956354da8000001c5-1493992225.467577-93714130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:52:30 INFO - MultiFileLogger online at 20170505 06:52:30 in /builds/slave/test 06:52:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 06:52:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:52:30 INFO - {'append_to_log': False, 06:52:30 INFO - 'base_work_dir': '/builds/slave/test', 06:52:30 INFO - 'blob_upload_branch': 'Firefox', 06:52:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:52:30 INFO - 'branch': 'Firefox', 06:52:30 INFO - 'buildbot_json_path': 'buildprops.json', 06:52:30 INFO - 'config_files': ('talos/linux_config.py',), 06:52:30 INFO - 'default_actions': ('clobber', 06:52:30 INFO - 'read-buildbot-config', 06:52:30 INFO - 'download-and-extract', 06:52:30 INFO - 'populate-webroot', 06:52:30 INFO - 'create-virtualenv', 06:52:30 INFO - 'install', 06:52:30 INFO - 'run-tests'), 06:52:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:52:30 INFO - 'download_minidump_stackwalk': True, 06:52:30 INFO - 'download_symbols': 'ondemand', 06:52:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:52:30 INFO - 'tooltool.py': '/tools/tooltool.py', 06:52:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:52:30 INFO - '/tools/misc-python/virtualenv.py')}, 06:52:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:52:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:52:30 INFO - 'gecko_profile': False, 06:52:30 INFO - 'gecko_profile_interval': 0, 06:52:30 INFO - 'installer_path': 'installer.exe', 06:52:30 INFO - 'log_level': 'info', 06:52:30 INFO - 'log_name': 'talos', 06:52:30 INFO - 'log_to_console': True, 06:52:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:52:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:52:30 INFO - 'opt_config_files': (), 06:52:30 INFO - 'pip_index': False, 06:52:30 INFO - 'suite': 'dromaeojs-e10s', 06:52:30 INFO - 'system_bits': '32', 06:52:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:52:30 INFO - 'title': 'talos-linux64-ix-026', 06:52:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:52:30 INFO - 'use_talos_json': True, 06:52:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:52:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:52:30 INFO - 'work_dir': 'build'} 06:52:30 INFO - [mozharness: 2017-05-05 13:52:30.941920Z] Running clobber step. 06:52:30 INFO - Running pre-action listener: _resource_record_pre_action 06:52:30 INFO - Running main action method: clobber 06:52:30 INFO - rmtree: /builds/slave/test/build 06:52:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:52:31 INFO - Running post-action listener: _resource_record_post_action 06:52:31 INFO - [mozharness: 2017-05-05 13:52:31.874374Z] Finished clobber step (success) 06:52:31 INFO - [mozharness: 2017-05-05 13:52:31.874475Z] Running read-buildbot-config step. 06:52:31 INFO - Running pre-action listener: _resource_record_pre_action 06:52:31 INFO - Running main action method: read_buildbot_config 06:52:31 INFO - Using buildbot properties: 06:52:31 INFO - { 06:52:31 INFO - "project": "", 06:52:31 INFO - "product": "firefox", 06:52:31 INFO - "who": "cbook@mozilla.com", 06:52:31 INFO - "installer_path": "public/build/target.tar.bz2", 06:52:31 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 06:52:31 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 06:52:31 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 06:52:31 INFO - "stage_platform": "linux64-stylo", 06:52:31 INFO - "basedir": "/builds/slave/test", 06:52:31 INFO - "buildnumber": 79, 06:52:31 INFO - "platform": "ubuntu64_hw_stylo", 06:52:31 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:52:31 INFO - "slavebuilddir": "test", 06:52:31 INFO - "taskId": "L7RbGts5SUexykGTdeuzfQ", 06:52:31 INFO - "branch": "mozilla-central", 06:52:31 INFO - "script_repo_revision": "production", 06:52:31 INFO - "revision": "9348b76977e833f108cf77dff75b0fab887a2fc1", 06:52:31 INFO - "slavename": "talos-linux64-ix-026", 06:52:31 INFO - "repo_path": "mozilla-central" 06:52:31 INFO - } 06:52:31 INFO - Finding installer, test and symbols from parent task. 06:52:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L7RbGts5SUexykGTdeuzfQ'}, attempt #1 06:52:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L7RbGts5SUexykGTdeuzfQ'}, attempt #1 06:52:32 INFO - Task dependencies: EMsWWJAtR8KN2KkWpNBSIA 06:52:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EMsWWJAtR8KN2KkWpNBSIA'}, attempt #1 06:52:33 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/EMsWWJAtR8KN2KkWpNBSIA/artifacts/public/build/target.tar.bz2 06:52:33 INFO - Set test_url: https://queue.taskcluster.net/v1/task/EMsWWJAtR8KN2KkWpNBSIA/artifacts/public/build/test_packages.json 06:52:33 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/EMsWWJAtR8KN2KkWpNBSIA/artifacts/public/build/target.crashreporter-symbols.zip 06:52:33 INFO - Running post-action listener: _resource_record_post_action 06:52:33 INFO - [mozharness: 2017-05-05 13:52:33.232710Z] Finished read-buildbot-config step (success) 06:52:33 INFO - [mozharness: 2017-05-05 13:52:33.232928Z] Running download-and-extract step. 06:52:33 INFO - Running pre-action listener: _resource_record_pre_action 06:52:33 INFO - Running main action method: download_and_extract 06:52:33 INFO - mkdir: /builds/slave/test/build/tests 06:52:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:52:33 INFO - trying https://queue.taskcluster.net/v1/task/EMsWWJAtR8KN2KkWpNBSIA/artifacts/public/build/target.test_packages.json 06:52:33 INFO - Downloading https://queue.taskcluster.net/v1/task/EMsWWJAtR8KN2KkWpNBSIA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 06:52:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EMsWWJAtR8KN2KkWpNBSIA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 06:52:33 INFO - Downloaded 986 bytes. 06:52:33 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 06:52:33 INFO - Using the following test package requirements: 06:52:33 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 06:52:33 INFO - u'common': [u'target.common.tests.zip'], 06:52:33 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 06:52:33 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 06:52:33 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 06:52:33 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 06:52:33 INFO - u'mozbase': [u'target.common.tests.zip'], 06:52:33 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 06:52:33 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 06:52:33 INFO - u'web-platform': [u'target.common.tests.zip', 06:52:33 INFO - u'target.web-platform.tests.zip'], 06:52:33 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 06:52:33 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 06:52:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EMsWWJAtR8KN2KkWpNBSIA/artifacts/public/build/target.common.tests.zip 06:52:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EMsWWJAtR8KN2KkWpNBSIA/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:52:33 INFO - Fetch https://queue.taskcluster.net/v1/task/EMsWWJAtR8KN2KkWpNBSIA/artifacts/public/build/target.common.tests.zip into memory 06:52:34 INFO - Content-Length response header: 58449524 06:52:34 INFO - Bytes received: 58449524 06:52:44 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 06:52:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EMsWWJAtR8KN2KkWpNBSIA/artifacts/public/build/target.common.tests.zip 06:52:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EMsWWJAtR8KN2KkWpNBSIA/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:52:44 INFO - Fetch https://queue.taskcluster.net/v1/task/EMsWWJAtR8KN2KkWpNBSIA/artifacts/public/build/target.common.tests.zip into memory 06:52:45 INFO - Content-Length response header: 58449524 06:52:45 INFO - Bytes received: 58449524 06:52:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EMsWWJAtR8KN2KkWpNBSIA/artifacts/public/build/target.talos.tests.zip 06:52:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EMsWWJAtR8KN2KkWpNBSIA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 06:52:56 INFO - Fetch https://queue.taskcluster.net/v1/task/EMsWWJAtR8KN2KkWpNBSIA/artifacts/public/build/target.talos.tests.zip into memory 06:52:57 INFO - Content-Length response header: 14408697 06:52:57 INFO - Bytes received: 14408697 06:52:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:52:57 INFO - trying https://queue.taskcluster.net/v1/task/EMsWWJAtR8KN2KkWpNBSIA/artifacts/public/build/target.tar.bz2 06:52:57 INFO - Downloading https://queue.taskcluster.net/v1/task/EMsWWJAtR8KN2KkWpNBSIA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 06:52:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EMsWWJAtR8KN2KkWpNBSIA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 06:52:58 INFO - Downloaded 59943330 bytes. 06:52:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EMsWWJAtR8KN2KkWpNBSIA/artifacts/public/build/target.tar.bz2 06:52:58 INFO - mkdir: /builds/slave/test/properties 06:52:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:52:58 INFO - Writing to file /builds/slave/test/properties/build_url 06:52:58 INFO - Contents: 06:52:58 INFO - build_url:https://queue.taskcluster.net/v1/task/EMsWWJAtR8KN2KkWpNBSIA/artifacts/public/build/target.tar.bz2 06:52:58 INFO - Running post-action listener: _resource_record_post_action 06:52:58 INFO - Running post-action listener: set_extra_try_arguments 06:52:58 INFO - [mozharness: 2017-05-05 13:52:58.598149Z] Finished download-and-extract step (success) 06:52:58 INFO - [mozharness: 2017-05-05 13:52:58.598246Z] Running populate-webroot step. 06:52:58 INFO - Running pre-action listener: _resource_record_pre_action 06:52:58 INFO - Running main action method: populate_webroot 06:52:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:52:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:52:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:52:58 INFO - '--tppagecycles', 06:52:58 INFO - '7'], 06:52:58 INFO - 'tests': ['tsvgm']}}, 06:52:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:52:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:52:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:52:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:52:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:52:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:52:58 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 06:52:58 INFO - 'talos_options': ['--disable-e10s'], 06:52:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:52:58 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:52:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:52:58 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 06:52:58 INFO - 'talos_options': ['--disable-e10s'], 06:52:58 INFO - 'tests': ['damp', 'tps']}, 06:52:58 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:52:58 INFO - 'tests': ['damp', 'tps']}, 06:52:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:52:58 INFO - 'tests': ['dromaeo_dom']}, 06:52:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:52:58 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:52:58 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 06:52:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 06:52:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:52:58 INFO - 'tests': ['a11yr', 06:52:58 INFO - 'ts_paint', 06:52:58 INFO - 'tpaint', 06:52:58 INFO - 'sessionrestore', 06:52:58 INFO - 'sessionrestore_no_auto_restore', 06:52:58 INFO - 'tabpaint']}, 06:52:58 INFO - 'other-e10s': {'tests': ['a11yr', 06:52:58 INFO - 'ts_paint', 06:52:58 INFO - 'tpaint', 06:52:58 INFO - 'sessionrestore', 06:52:58 INFO - 'sessionrestore_no_auto_restore', 06:52:58 INFO - 'tabpaint']}, 06:52:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:52:58 INFO - 'ts_paint', 06:52:58 INFO - 'tpaint', 06:52:58 INFO - 'sessionrestore', 06:52:58 INFO - 'sessionrestore_no_auto_restore', 06:52:58 INFO - 'tabpaint']}, 06:52:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:52:58 INFO - 'ts_paint', 06:52:58 INFO - 'tpaint', 06:52:58 INFO - 'sessionrestore', 06:52:58 INFO - 'sessionrestore_no_auto_restore', 06:52:58 INFO - 'tabpaint']}, 06:52:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:52:58 INFO - 'tests': ['a11yr', 06:52:58 INFO - 'ts_paint', 06:52:58 INFO - 'tpaint', 06:52:58 INFO - 'sessionrestore', 06:52:58 INFO - 'sessionrestore_no_auto_restore', 06:52:58 INFO - 'tabpaint']}, 06:52:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:52:58 INFO - 'tests': ['a11yr', 06:52:58 INFO - 'ts_paint', 06:52:58 INFO - 'tpaint', 06:52:58 INFO - 'sessionrestore', 06:52:58 INFO - 'sessionrestore_no_auto_restore', 06:52:58 INFO - 'tabpaint']}, 06:52:58 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 06:52:58 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 06:52:58 INFO - 'bloom_basic_ref']}, 06:52:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:52:58 INFO - 'tests': ['tsvgx', 06:52:58 INFO - 'tsvgr_opacity', 06:52:58 INFO - 'tart', 06:52:58 INFO - 'tscrollx', 06:52:58 INFO - 'cart', 06:52:58 INFO - 'tsvg_static']}, 06:52:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:52:58 INFO - 'tsvgr_opacity', 06:52:58 INFO - 'tart', 06:52:58 INFO - 'tscrollx', 06:52:58 INFO - 'cart', 06:52:58 INFO - 'tsvg_static']}, 06:52:58 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 06:52:58 INFO - 'talos_options': ['--disable-e10s'], 06:52:58 INFO - 'tests': ['tp5o']}, 06:52:58 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:52:58 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 06:52:58 INFO - 'talos_options': ['--disable-e10s', 06:52:58 INFO - '--xperf_path', 06:52:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:52:58 INFO - 'tests': ['tp5n']}, 06:52:58 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:52:58 INFO - 'talos_options': ['--xperf_path', 06:52:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:52:58 INFO - 'tests': ['tp5n']}}, 06:52:58 INFO - 'talos.zip': {'path': '', 06:52:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:52:58 INFO - Running post-action listener: _resource_record_post_action 06:52:58 INFO - [mozharness: 2017-05-05 13:52:58.612007Z] Finished populate-webroot step (success) 06:52:58 INFO - [mozharness: 2017-05-05 13:52:58.612097Z] Running create-virtualenv step. 06:52:58 INFO - Running pre-action listener: _resource_record_pre_action 06:52:58 INFO - Running main action method: create_virtualenv 06:52:58 INFO - Creating virtualenv /builds/slave/test/build/venv 06:52:58 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 06:52:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:52:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:52:58 INFO - Using real prefix '/usr' 06:52:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:52:59 INFO - Installing distribute.............................................................................................................................................................................................done. 06:53:01 INFO - Installing pip.................done. 06:53:01 INFO - Return code: 0 06:53:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:53:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:53:01 INFO - Reading from file tmpfile_stdout 06:53:01 INFO - Output received: 06:53:01 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) 06:53:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:53:01 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')]} 06:53:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:53:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:01 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')]} 06:53:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:53:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:01 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 0x21421f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x223aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23dfb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23dd290>, '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 0x23ddb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23de040>, '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': '41bf3e9aed84707956354da8000001c5-1493992225.467577-93714130', '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 06:53:01 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 06:53:01 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 06:53:01 INFO - Using env: {'DISPLAY': ':0', 06:53:01 INFO - 'HOME': '/home/cltbld', 06:53:01 INFO - 'LANG': 'en_US.UTF-8', 06:53:01 INFO - 'LANGUAGE': 'en_US:en', 06:53:01 INFO - 'LOGNAME': 'cltbld', 06:53:01 INFO - 'MAIL': '/var/mail/cltbld', 06:53:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:53:01 INFO - 'MOZ_NO_REMOTE': '1', 06:53:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:53:01 INFO - 'NO_EM_RESTART': '1', 06:53:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:53:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:53:01 INFO - 'PWD': '/builds/slave/test', 06:53:01 INFO - 'SHELL': '/bin/bash', 06:53:01 INFO - 'SHLVL': '1', 06:53:01 INFO - 'TERM': 'linux', 06:53:01 INFO - 'TMOUT': '86400', 06:53:01 INFO - 'USER': 'cltbld', 06:53:01 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1493992225.467577-93714130', 06:53:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:53:01 INFO - '_': '/tools/buildbot/bin/python'} 06:53:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:53:01 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 06:53:01 INFO - Cleaning up... 06:53:01 INFO - Return code: 0 06:53:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:53:01 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')]} 06:53:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:53:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:01 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')]} 06:53:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:53:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:01 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 0x21421f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x223aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23dfb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23dd290>, '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 0x23ddb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23de040>, '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': '41bf3e9aed84707956354da8000001c5-1493992225.467577-93714130', '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 06:53:01 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 06:53:01 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 06:53:01 INFO - Using env: {'DISPLAY': ':0', 06:53:01 INFO - 'HOME': '/home/cltbld', 06:53:01 INFO - 'LANG': 'en_US.UTF-8', 06:53:01 INFO - 'LANGUAGE': 'en_US:en', 06:53:01 INFO - 'LOGNAME': 'cltbld', 06:53:01 INFO - 'MAIL': '/var/mail/cltbld', 06:53:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:53:01 INFO - 'MOZ_NO_REMOTE': '1', 06:53:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:53:01 INFO - 'NO_EM_RESTART': '1', 06:53:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:53:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:53:01 INFO - 'PWD': '/builds/slave/test', 06:53:01 INFO - 'SHELL': '/bin/bash', 06:53:01 INFO - 'SHLVL': '1', 06:53:01 INFO - 'TERM': 'linux', 06:53:01 INFO - 'TMOUT': '86400', 06:53:01 INFO - 'USER': 'cltbld', 06:53:01 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1493992225.467577-93714130', 06:53:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:53:01 INFO - '_': '/tools/buildbot/bin/python'} 06:53:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:53:01 INFO - Downloading/unpacking psutil>=3.1.1 06:53:01 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 06:53:01 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 06:53:01 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 06:53:01 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 06:53:01 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 06:53:01 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 06:53:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:53:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:53:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:53:03 INFO - Installing collected packages: psutil 06:53:03 INFO - Running setup.py install for psutil 06:53:03 INFO - building 'psutil._psutil_linux' extension 06:53:03 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 06:53:03 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 06:53:03 INFO - building 'psutil._psutil_posix' extension 06:53:03 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 06:53:03 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 06:53:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:53:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:53:03 INFO - Successfully installed psutil 06:53:03 INFO - Cleaning up... 06:53:03 INFO - Return code: 0 06:53:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:53: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')]} 06:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:53:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53: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')]} 06:53:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:53:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53: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 0x21421f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x223aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23dfb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23dd290>, '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 0x23ddb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23de040>, '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': '41bf3e9aed84707956354da8000001c5-1493992225.467577-93714130', '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 06:53: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 06:53: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 06:53:03 INFO - Using env: {'DISPLAY': ':0', 06:53:03 INFO - 'HOME': '/home/cltbld', 06:53:03 INFO - 'LANG': 'en_US.UTF-8', 06:53:03 INFO - 'LANGUAGE': 'en_US:en', 06:53:03 INFO - 'LOGNAME': 'cltbld', 06:53:03 INFO - 'MAIL': '/var/mail/cltbld', 06:53:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:53:03 INFO - 'MOZ_NO_REMOTE': '1', 06:53:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:53:03 INFO - 'NO_EM_RESTART': '1', 06:53:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:53:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:53:03 INFO - 'PWD': '/builds/slave/test', 06:53:03 INFO - 'SHELL': '/bin/bash', 06:53:03 INFO - 'SHLVL': '1', 06:53:03 INFO - 'TERM': 'linux', 06:53:03 INFO - 'TMOUT': '86400', 06:53:03 INFO - 'USER': 'cltbld', 06:53:03 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1493992225.467577-93714130', 06:53:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:53:03 INFO - '_': '/tools/buildbot/bin/python'} 06:53:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:53:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:53: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 06:53: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 06:53: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 06:53: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 06:53: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 06:53: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 06:53:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:53:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:53:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:53:04 INFO - Installing collected packages: mozsystemmonitor 06:53:04 INFO - Running setup.py install for mozsystemmonitor 06:53:04 INFO - Successfully installed mozsystemmonitor 06:53:05 INFO - Cleaning up... 06:53:05 INFO - Return code: 0 06:53:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:53: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')]} 06:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:53:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53: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')]} 06:53:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:53:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53: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 0x21421f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x223aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23dfb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23dd290>, '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 0x23ddb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23de040>, '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': '41bf3e9aed84707956354da8000001c5-1493992225.467577-93714130', '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 06:53: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 06:53: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 06:53:05 INFO - Using env: {'DISPLAY': ':0', 06:53:05 INFO - 'HOME': '/home/cltbld', 06:53:05 INFO - 'LANG': 'en_US.UTF-8', 06:53:05 INFO - 'LANGUAGE': 'en_US:en', 06:53:05 INFO - 'LOGNAME': 'cltbld', 06:53:05 INFO - 'MAIL': '/var/mail/cltbld', 06:53:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:53:05 INFO - 'MOZ_NO_REMOTE': '1', 06:53:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:53:05 INFO - 'NO_EM_RESTART': '1', 06:53:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:53:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:53:05 INFO - 'PWD': '/builds/slave/test', 06:53:05 INFO - 'SHELL': '/bin/bash', 06:53:05 INFO - 'SHLVL': '1', 06:53:05 INFO - 'TERM': 'linux', 06:53:05 INFO - 'TMOUT': '86400', 06:53:05 INFO - 'USER': 'cltbld', 06:53:05 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1493992225.467577-93714130', 06:53:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:53:05 INFO - '_': '/tools/buildbot/bin/python'} 06:53:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:53:05 INFO - Downloading/unpacking jsonschema==2.5.1 06:53: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 06:53: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 06:53: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 06:53: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 06:53: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 06:53: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 06:53:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:53:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:53:06 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 06:53:06 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 06:53:06 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 06:53:06 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 06:53:06 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 06:53:06 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 06:53:06 INFO - Downloading functools32-3.2.3-2.tar.gz 06:53:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:53:06 INFO - warning: no files found matching '*.txt' 06:53:06 INFO - no previously-included directories found matching 'build' 06:53:06 INFO - no previously-included directories found matching 'dist' 06:53:06 INFO - no previously-included directories found matching '.git*' 06:53:06 INFO - Installing collected packages: jsonschema, functools32 06:53:06 INFO - Running setup.py install for functools32 06:53:06 INFO - warning: no files found matching '*.txt' 06:53:06 INFO - no previously-included directories found matching 'build' 06:53:06 INFO - no previously-included directories found matching 'dist' 06:53:06 INFO - no previously-included directories found matching '.git*' 06:53:06 INFO - Successfully installed jsonschema functools32 06:53:06 INFO - Cleaning up... 06:53:06 INFO - Return code: 0 06:53:06 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:53:06 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')]} 06:53:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:53:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:06 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')]} 06:53:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:53:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:06 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 0x21421f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x223aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23dfb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23dd290>, '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 0x23ddb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23de040>, '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': '41bf3e9aed84707956354da8000001c5-1493992225.467577-93714130', '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 06:53:06 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 06:53:06 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 06:53:06 INFO - Using env: {'DISPLAY': ':0', 06:53:06 INFO - 'HOME': '/home/cltbld', 06:53:06 INFO - 'LANG': 'en_US.UTF-8', 06:53:06 INFO - 'LANGUAGE': 'en_US:en', 06:53:06 INFO - 'LOGNAME': 'cltbld', 06:53:06 INFO - 'MAIL': '/var/mail/cltbld', 06:53:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:53:06 INFO - 'MOZ_NO_REMOTE': '1', 06:53:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:53:06 INFO - 'NO_EM_RESTART': '1', 06:53:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:53:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:53:06 INFO - 'PWD': '/builds/slave/test', 06:53:06 INFO - 'SHELL': '/bin/bash', 06:53:06 INFO - 'SHLVL': '1', 06:53:06 INFO - 'TERM': 'linux', 06:53:06 INFO - 'TMOUT': '86400', 06:53:06 INFO - 'USER': 'cltbld', 06:53:06 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1493992225.467577-93714130', 06:53:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:53:06 INFO - '_': '/tools/buildbot/bin/python'} 06:53:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:53:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:53:06 INFO - Cleaning up... 06:53:06 INFO - Return code: 0 06:53:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:53:06 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')]} 06:53:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:53:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:06 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')]} 06:53:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:53:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:06 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 0x21421f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x223aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23dfb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23dd290>, '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 0x23ddb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23de040>, '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': '41bf3e9aed84707956354da8000001c5-1493992225.467577-93714130', '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 06:53:06 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 06:53:06 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 06:53:06 INFO - Using env: {'DISPLAY': ':0', 06:53:06 INFO - 'HOME': '/home/cltbld', 06:53:06 INFO - 'LANG': 'en_US.UTF-8', 06:53:06 INFO - 'LANGUAGE': 'en_US:en', 06:53:06 INFO - 'LOGNAME': 'cltbld', 06:53:06 INFO - 'MAIL': '/var/mail/cltbld', 06:53:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:53:06 INFO - 'MOZ_NO_REMOTE': '1', 06:53:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:53:06 INFO - 'NO_EM_RESTART': '1', 06:53:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:53:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:53:06 INFO - 'PWD': '/builds/slave/test', 06:53:06 INFO - 'SHELL': '/bin/bash', 06:53:06 INFO - 'SHLVL': '1', 06:53:06 INFO - 'TERM': 'linux', 06:53:06 INFO - 'TMOUT': '86400', 06:53:06 INFO - 'USER': 'cltbld', 06:53:06 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1493992225.467577-93714130', 06:53:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:53:06 INFO - '_': '/tools/buildbot/bin/python'} 06:53:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:53:07 INFO - Downloading/unpacking blobuploader==1.2.4 06:53: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 06:53: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 06:53: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 06:53: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 06:53: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 06:53: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 06:53:08 INFO - Downloading blobuploader-1.2.4.tar.gz 06:53:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:53:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:53: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 06:53: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 06:53: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 06:53: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 06:53: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 06:53: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 06:53:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:53:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:53: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 06:53: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 06:53: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 06:53: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 06:53: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 06:53: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 06:53:08 INFO - Downloading docopt-0.6.1.tar.gz 06:53:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:53:08 INFO - Installing collected packages: blobuploader, requests, docopt 06:53:08 INFO - Running setup.py install for blobuploader 06:53:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:53:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:53:08 INFO - Running setup.py install for requests 06:53:09 INFO - Running setup.py install for docopt 06:53:09 INFO - Successfully installed blobuploader requests docopt 06:53:09 INFO - Cleaning up... 06:53:09 INFO - Return code: 0 06:53:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:53:09 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')]} 06:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:53:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:09 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')]} 06:53:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:53:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:09 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 0x21421f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x223aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23dfb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23dd290>, '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 0x23ddb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23de040>, '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': '41bf3e9aed84707956354da8000001c5-1493992225.467577-93714130', '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 06:53:09 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 06:53:09 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 06:53:09 INFO - Using env: {'DISPLAY': ':0', 06:53:09 INFO - 'HOME': '/home/cltbld', 06:53:09 INFO - 'LANG': 'en_US.UTF-8', 06:53:09 INFO - 'LANGUAGE': 'en_US:en', 06:53:09 INFO - 'LOGNAME': 'cltbld', 06:53:09 INFO - 'MAIL': '/var/mail/cltbld', 06:53:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:53:09 INFO - 'MOZ_NO_REMOTE': '1', 06:53:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:53:09 INFO - 'NO_EM_RESTART': '1', 06:53:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:53:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:53:09 INFO - 'PWD': '/builds/slave/test', 06:53:09 INFO - 'SHELL': '/bin/bash', 06:53:09 INFO - 'SHLVL': '1', 06:53:09 INFO - 'TERM': 'linux', 06:53:09 INFO - 'TMOUT': '86400', 06:53:09 INFO - 'USER': 'cltbld', 06:53:09 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1493992225.467577-93714130', 06:53:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:53:09 INFO - '_': '/tools/buildbot/bin/python'} 06:53:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:53:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:53:09 INFO - Running setup.py (path:/tmp/pip-U2z9CG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:53:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:53:09 INFO - Running setup.py (path:/tmp/pip-n6qGXh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:53:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:53:09 INFO - Running setup.py (path:/tmp/pip-cm1CJs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:53:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:53:09 INFO - Running setup.py (path:/tmp/pip-hdDpmf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:53:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:53:09 INFO - Running setup.py (path:/tmp/pip-7pU5DP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:53:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:53:09 INFO - Running setup.py (path:/tmp/pip-CZ5tHq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:53:10 INFO - Running setup.py (path:/tmp/pip-mhO1hm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:53:10 INFO - Running setup.py (path:/tmp/pip-Pwdbkh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:53:10 INFO - Running setup.py (path:/tmp/pip-bwFefx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:53:10 INFO - Running setup.py (path:/tmp/pip-yMWnvO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:53:10 INFO - Running setup.py (path:/tmp/pip-i6gmy7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:53:10 INFO - Running setup.py (path:/tmp/pip-S2nGGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:53:10 INFO - Running setup.py (path:/tmp/pip-Ii4Ivd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:53:10 INFO - Running setup.py (path:/tmp/pip-HDDuEo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:53:10 INFO - Running setup.py (path:/tmp/pip-3GdB7B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:53:10 INFO - Running setup.py (path:/tmp/pip-RM9Ebu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:53:10 INFO - Running setup.py (path:/tmp/pip-9aKidv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:53:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:53:10 INFO - Running setup.py install for manifestparser 06:53:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:53:10 INFO - Running setup.py install for mozcrash 06:53:11 INFO - Running setup.py install for mozdebug 06:53:11 INFO - Running setup.py install for mozdevice 06:53:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:53:11 INFO - Running setup.py install for mozfile 06:53:11 INFO - Running setup.py install for mozhttpd 06:53:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:53:11 INFO - Running setup.py install for mozinfo 06:53:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:53:11 INFO - Running setup.py install for mozInstall 06:53:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:53:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:53:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:53:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:53:11 INFO - Running setup.py install for mozleak 06:53:11 INFO - Running setup.py install for mozlog 06:53:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:53:11 INFO - Running setup.py install for moznetwork 06:53:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:53:11 INFO - Running setup.py install for mozprocess 06:53:12 INFO - Running setup.py install for mozprofile 06:53:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:53:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:53:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:53:12 INFO - Running setup.py install for mozrunner 06:53:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:53:12 INFO - Running setup.py install for mozscreenshot 06:53:12 INFO - Running setup.py install for moztest 06:53:12 INFO - Running setup.py install for mozversion 06:53:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:53:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:53:12 INFO - Cleaning up... 06:53:12 INFO - Return code: 0 06:53:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:53: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')]} 06:53:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:53:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53: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')]} 06:53:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:53:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:12 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 0x21421f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x223aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23dfb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23dd290>, '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 0x23ddb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23de040>, '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': '41bf3e9aed84707956354da8000001c5-1493992225.467577-93714130', '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 06:53:12 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 06:53:12 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 06:53:12 INFO - Using env: {'DISPLAY': ':0', 06:53:12 INFO - 'HOME': '/home/cltbld', 06:53:12 INFO - 'LANG': 'en_US.UTF-8', 06:53:12 INFO - 'LANGUAGE': 'en_US:en', 06:53:12 INFO - 'LOGNAME': 'cltbld', 06:53:12 INFO - 'MAIL': '/var/mail/cltbld', 06:53:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:53:12 INFO - 'MOZ_NO_REMOTE': '1', 06:53:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:53:12 INFO - 'NO_EM_RESTART': '1', 06:53:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:53:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:53:12 INFO - 'PWD': '/builds/slave/test', 06:53:12 INFO - 'SHELL': '/bin/bash', 06:53:12 INFO - 'SHLVL': '1', 06:53:12 INFO - 'TERM': 'linux', 06:53:12 INFO - 'TMOUT': '86400', 06:53:12 INFO - 'USER': 'cltbld', 06:53:12 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1493992225.467577-93714130', 06:53:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:53:12 INFO - '_': '/tools/buildbot/bin/python'} 06:53:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:53:12 INFO - Running setup.py (path:/tmp/pip-i21QZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:53:12 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)) 06:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:53:12 INFO - Running setup.py (path:/tmp/pip-D9vJxQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:53:12 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)) 06:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:53:12 INFO - Running setup.py (path:/tmp/pip-zdCqW1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:53:13 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)) 06:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:53:13 INFO - Running setup.py (path:/tmp/pip-hJldGb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:53:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:53:13 INFO - Running setup.py (path:/tmp/pip-sjWxzp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:53:13 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)) 06:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:53:13 INFO - Running setup.py (path:/tmp/pip-g2KkWa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:53:13 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)) 06:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:53:13 INFO - Running setup.py (path:/tmp/pip-VflrOp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:53:13 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)) 06:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:53:13 INFO - Running setup.py (path:/tmp/pip-0bSMQS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:53:13 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)) 06:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:53:13 INFO - Running setup.py (path:/tmp/pip-SftkGN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:53:13 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)) 06:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:53:13 INFO - Running setup.py (path:/tmp/pip-s_oBAp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:53:13 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)) 06:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:53:13 INFO - Running setup.py (path:/tmp/pip-lQx1LL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:53:13 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)) 06:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:53:13 INFO - Running setup.py (path:/tmp/pip-A9mLRP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:53:13 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)) 06:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:53:13 INFO - Running setup.py (path:/tmp/pip-D_M3o1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:53:13 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)) 06:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:53:13 INFO - Running setup.py (path:/tmp/pip-k1F_HM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:53:13 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)) 06:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:53:13 INFO - Running setup.py (path:/tmp/pip-tB8uPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:53:13 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)) 06:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:53:13 INFO - Running setup.py (path:/tmp/pip-7eJ9Vd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:53:14 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)) 06:53:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:53:14 INFO - Running setup.py (path:/tmp/pip-kyZwSY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:53:14 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)) 06:53:14 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)) 06:53:14 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)) 06:53:14 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)) 06:53:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:53:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:53:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:53:14 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 06:53:14 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 06:53:14 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 06:53:14 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 06:53:14 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 06:53:14 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 06:53:15 INFO - Downloading blessings-1.6.tar.gz 06:53:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:53:15 INFO - Installing collected packages: blessings 06:53:15 INFO - Running setup.py install for blessings 06:53:15 INFO - Successfully installed blessings 06:53:15 INFO - Cleaning up... 06:53:15 INFO - Return code: 0 06:53:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:53:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:53:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:53:15 INFO - Reading from file tmpfile_stdout 06:53:15 INFO - Current package versions: 06:53:15 INFO - argparse == 1.2.1 06:53:15 INFO - blessings == 1.6 06:53:15 INFO - blobuploader == 1.2.4 06:53:15 INFO - docopt == 0.6.1 06:53:15 INFO - functools32 == 3.2.3-2 06:53:15 INFO - jsonschema == 2.5.1 06:53:15 INFO - manifestparser == 1.1 06:53:15 INFO - mozInstall == 1.12 06:53:15 INFO - mozcrash == 1.0 06:53:15 INFO - mozdebug == 0.1 06:53:15 INFO - mozdevice == 0.50 06:53:15 INFO - mozfile == 1.2 06:53:15 INFO - mozhttpd == 0.7 06:53:15 INFO - mozinfo == 0.9 06:53:15 INFO - mozleak == 0.1 06:53:15 INFO - mozlog == 3.4 06:53:15 INFO - moznetwork == 0.27 06:53:15 INFO - mozprocess == 0.25 06:53:15 INFO - mozprofile == 0.28 06:53:15 INFO - mozrunner == 6.13 06:53:15 INFO - mozscreenshot == 0.1 06:53:15 INFO - mozsystemmonitor == 0.3 06:53:15 INFO - moztest == 0.8 06:53:15 INFO - mozversion == 1.4 06:53:15 INFO - psutil == 3.1.1 06:53:15 INFO - requests == 1.2.3 06:53:15 INFO - wsgiref == 0.1.2 06:53:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:53: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')]} 06:53:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:53:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53: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')]} 06:53:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:53:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:15 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 0x21421f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x223aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23dfb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23dd290>, '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 0x23ddb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23de040>, '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': '41bf3e9aed84707956354da8000001c5-1493992225.467577-93714130', '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 06:53:15 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 06:53:15 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 06:53:15 INFO - Using env: {'DISPLAY': ':0', 06:53:15 INFO - 'HOME': '/home/cltbld', 06:53:15 INFO - 'LANG': 'en_US.UTF-8', 06:53:15 INFO - 'LANGUAGE': 'en_US:en', 06:53:15 INFO - 'LOGNAME': 'cltbld', 06:53:15 INFO - 'MAIL': '/var/mail/cltbld', 06:53:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:53:15 INFO - 'MOZ_NO_REMOTE': '1', 06:53:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:53:15 INFO - 'NO_EM_RESTART': '1', 06:53:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:53:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:53:15 INFO - 'PWD': '/builds/slave/test', 06:53:15 INFO - 'SHELL': '/bin/bash', 06:53:15 INFO - 'SHLVL': '1', 06:53:15 INFO - 'TERM': 'linux', 06:53:15 INFO - 'TMOUT': '86400', 06:53:15 INFO - 'USER': 'cltbld', 06:53:15 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1493992225.467577-93714130', 06:53:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:53:15 INFO - '_': '/tools/buildbot/bin/python'} 06:53:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:53:15 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)) 06:53:15 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)) 06:53:15 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)) 06:53:15 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)) 06:53:15 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)) 06:53:15 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)) 06:53:15 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)) 06:53:15 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)) 06:53:15 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)) 06:53:15 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)) 06:53:15 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)) 06:53:15 INFO - Cleaning up... 06:53:15 INFO - Return code: 0 06:53:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:53: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')]} 06:53:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:53:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53: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')]} 06:53:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:53:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21421f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x223aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23dfb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23dd290>, '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 0x23ddb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23de040>, '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': '41bf3e9aed84707956354da8000001c5-1493992225.467577-93714130', '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 06:53:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:53:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:53:15 INFO - Using env: {'DISPLAY': ':0', 06:53:15 INFO - 'HOME': '/home/cltbld', 06:53:15 INFO - 'LANG': 'en_US.UTF-8', 06:53:15 INFO - 'LANGUAGE': 'en_US:en', 06:53:15 INFO - 'LOGNAME': 'cltbld', 06:53:15 INFO - 'MAIL': '/var/mail/cltbld', 06:53:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:53:15 INFO - 'MOZ_NO_REMOTE': '1', 06:53:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:53:15 INFO - 'NO_EM_RESTART': '1', 06:53:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:53:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:53:15 INFO - 'PWD': '/builds/slave/test', 06:53:15 INFO - 'SHELL': '/bin/bash', 06:53:15 INFO - 'SHLVL': '1', 06:53:15 INFO - 'TERM': 'linux', 06:53:15 INFO - 'TMOUT': '86400', 06:53:15 INFO - 'USER': 'cltbld', 06:53:15 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1493992225.467577-93714130', 06:53:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:53:15 INFO - '_': '/tools/buildbot/bin/python'} 06:53:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:53:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:53:16 INFO - Cleaning up... 06:53:16 INFO - Return code: 0 06:53:16 INFO - Running post-action listener: _resource_record_post_action 06:53:16 INFO - Running post-action listener: _start_resource_monitoring 06:53:16 INFO - Starting resource monitoring. 06:53:16 INFO - [mozharness: 2017-05-05 13:53:16.108736Z] Finished create-virtualenv step (success) 06:53:16 INFO - [mozharness: 2017-05-05 13:53:16.109257Z] Running install step. 06:53:16 INFO - Running pre-action listener: _resource_record_pre_action 06:53:16 INFO - Running main action method: install 06:53:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:53:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:53:16 INFO - Reading from file tmpfile_stdout 06:53:16 INFO - Detecting whether we're running mozinstall >=1.0... 06:53:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:53:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:53:16 INFO - Reading from file tmpfile_stdout 06:53:16 INFO - Output received: 06:53:16 INFO - Usage: mozinstall [options] installer 06:53:16 INFO - Options: 06:53:16 INFO - -h, --help show this help message and exit 06:53:16 INFO - -d DEST, --destination=DEST 06:53:16 INFO - Directory to install application into. [default: 06:53:16 INFO - "/builds/slave/test"] 06:53:16 INFO - --app=APP Application being installed. [default: firefox] 06:53:16 INFO - mkdir: /builds/slave/test/build/application 06:53:16 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'] 06:53:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 06:53:31 INFO - Reading from file tmpfile_stdout 06:53:31 INFO - Output received: 06:53:31 INFO - /builds/slave/test/build/application/firefox/firefox 06:53:31 INFO - Running post-action listener: _resource_record_post_action 06:53:31 INFO - [mozharness: 2017-05-05 13:53:31.818722Z] Finished install step (success) 06:53:31 INFO - [mozharness: 2017-05-05 13:53:31.818996Z] Running run-tests step. 06:53:31 INFO - Running pre-action listener: _resource_record_pre_action 06:53:31 INFO - Running main action method: run_tests 06:53:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:53:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:53:31 INFO - Python 2.7.3 06:53:31 INFO - Return code: 0 06:53:31 INFO - grabbing minidump binary from tooltool 06:53: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')]} 06:53:31 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 0x23dd290>, '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 0x23ddb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23de040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:53:31 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 06:53:31 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 06:53:31 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 06:53:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:53:31 INFO - Return code: 0 06:53:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:53:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:53:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:53:31 INFO - ENV: RUST_BACKTRACE is now 1 06:53:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:53:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:53:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EMsWWJAtR8KN2KkWpNBSIA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 06:53:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EMsWWJAtR8KN2KkWpNBSIA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-026 --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 06:53:31 INFO - Using env: {'DISPLAY': ':0', 06:53:31 INFO - 'HOME': '/home/cltbld', 06:53:31 INFO - 'LANG': 'en_US.UTF-8', 06:53:31 INFO - 'LANGUAGE': 'en_US:en', 06:53:31 INFO - 'LOGNAME': 'cltbld', 06:53:31 INFO - 'MAIL': '/var/mail/cltbld', 06:53:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:53:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:53:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:53:31 INFO - 'MOZ_NO_REMOTE': '1', 06:53:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:53:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:53:31 INFO - 'NO_EM_RESTART': '1', 06:53:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:53:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:53:31 INFO - 'PWD': '/builds/slave/test', 06:53:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:53:31 INFO - 'RUST_BACKTRACE': '1', 06:53:31 INFO - 'SHELL': '/bin/bash', 06:53:31 INFO - 'SHLVL': '1', 06:53:31 INFO - 'TERM': 'linux', 06:53:31 INFO - 'TMOUT': '86400', 06:53:31 INFO - 'USER': 'cltbld', 06:53:31 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1493992225.467577-93714130', 06:53:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:53:31 INFO - '_': '/tools/buildbot/bin/python'} 06:53:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EMsWWJAtR8KN2KkWpNBSIA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 06:53:32 INFO - mozversion application_buildid: 20170505131750 06:53:32 INFO - mozversion application_changeset: 9348b76977e833f108cf77dff75b0fab887a2fc1 06:53:32 INFO - mozversion application_display_name: Nightly 06:53:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:53:32 INFO - mozversion application_name: Firefox 06:53:32 INFO - mozversion application_remotingname: firefox 06:53:32 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:53:32 INFO - mozversion application_vendor: Mozilla 06:53:32 INFO - mozversion application_version: 55.0a1 06:53:32 INFO - mozversion platform_buildid: 20170505131750 06:53:32 INFO - mozversion platform_changeset: 9348b76977e833f108cf77dff75b0fab887a2fc1 06:53:32 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:53:32 INFO - mozversion platform_version: 55.0a1 06:53:32 INFO - using testdate: 1493992412 06:53:32 INFO - actual date: 1493992412 06:53:32 INFO - starting webserver on 'localhost:33864' 06:53:32 INFO - SUITE-START | Running 2 tests 06:53:32 INFO - TEST-START | dromaeo_css 06:53:32 INFO - operating with platform_type : linux_ 06:53:32 INFO - Initialising browser for dromaeo_css test... 06:53:32 INFO - TEST-INFO | started process 32401 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFnQbTX/profile http://localhost:33864/getInfo.html) 06:53:36 INFO - PID 32401 | __metrics Screen width/height:1600/1200 06:53:36 INFO - PID 32401 | colorDepth:24 06:53:36 INFO - PID 32401 | Browser inner width/height: 1024/695 06:53:36 INFO - PID 32401 | __metrics 06:53:38 INFO - TEST-INFO | 32401: exit 0 06:53:38 INFO - Browser initialized. 06:53:38 INFO - Running cycle 1/1 for dromaeo_css test... 06:53:38 INFO - TEST-INFO | started process 32595 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFnQbTX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:53:50 INFO - PID 32595 | RSS: Main: 174071808 06:53:50 INFO - PID 32595 | 06:56:55 INFO - PID 32595 | Cycle 1(1): loaded http://localhost:33864/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33864/tests/dromaeo/cssquery-ext.html) 06:56:57 INFO - PID 32595 | RSS: Main: 180940800 06:56:57 INFO - PID 32595 | 06:59:59 INFO - PID 32595 | Cycle 1(1): loaded http://localhost:33864/tests/dromaeo/cssquery-ext.html (next: http://localhost:33864/tests/dromaeo/cssquery-jquery.html) 07:00:00 INFO - PID 32595 | RSS: Main: 177528832 07:00:00 INFO - PID 32595 | 07:03:02 INFO - PID 32595 | Cycle 1(1): loaded http://localhost:33864/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33864/tests/dromaeo/cssquery-mootools.html) 07:03:02 INFO - PID 32595 | RSS: Main: 186982400 07:03:02 INFO - PID 32595 | 07:06:04 INFO - PID 32595 | Cycle 1(1): loaded http://localhost:33864/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33864/tests/dromaeo/cssquery-prototype.html) 07:06:05 INFO - PID 32595 | RSS: Main: 178995200 07:06:05 INFO - PID 32595 | 07:09:08 INFO - PID 32595 | Cycle 1(1): loaded http://localhost:33864/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33864/tests/dromaeo/cssquery-yui.html) 07:09:08 INFO - PID 32595 | RSS: Main: 184815616 07:09:08 INFO - PID 32595 | 07:12:10 INFO - PID 32595 | Cycle 1(1): loaded http://localhost:33864/tests/dromaeo/cssquery-yui.html (next: http://localhost:33864/tests/dromaeo/cssquery-dojo.html) 07:12:10 INFO - PID 32595 | RSS: Main: 189272064 07:12:10 INFO - PID 32595 | 07:12:10 INFO - PID 32595 | __start_tp_report 07:12:10 INFO - PID 32595 | _x_x_mozilla_page_load 07:12:10 INFO - PID 32595 | _x_x_mozilla_page_load_details 07:12:10 INFO - PID 32595 | |i|pagename|runs| 07:12:10 INFO - PID 32595 | |0;dojo.html;2754.2976540982054;2781.123945957022;2802.663680358356;2813.4795062913363;2824.844633545154;5223.294855194547;5355.223492593572;5370.087085195516;5397.7031263280605;5414.40441551429;5263.26314315996;5329.626926115174;5349.384820745616;5424.972875135619;5454.154606036061;4443.290592743238;4712.387389639351;4715.717056976592;4730;4757.952420475785;4774.73738944358;4794.184988551937;4814.8314808981695;4825.927611085836;4832.855014349575;4584.243599806028;4665.113628410625;4699.342092107107;4763.476017638057;4792.568668819823;4775.474697783241;4780.7609619519235;4780.880477988043;4799.520047995173;4835.734034628094;4734.431868175807;4736.419587904712;4766.833160839354;4768.57082862544;4797.328374027639;5080.1363768159135;5157.8452646420665;5171.4311425743135;5237.397699264595;5284.920726189111;5741.081426971707;5753.597248192628;5755.0504166812425;5782.2483077199695;5816.069428891357;5756.827295181151;5773.595848290622;5776.10470377088;5779.537636989031;5781.653100813965;5188.636795424284;5260.237265596467;5332.653377530448;5335.1730481775;5335.866603334947;5747;5875.559333050039;5881.911771323434;5889.882202355929;5893.911591326134;5631.352394474606;5694.487496125369;5701.372848986608;5725.8568535786935;5752.827415177551;5734.684592347461;5785.652860828363;5795.913061304083;5795.9420405796245;5818.185454036438;5576.553875689935;5660.433956604306;5757.193992841006;5775.27809023872;5782.710864456844;5590.608657393944;5599.748011339418;5604.187392828017;5615.438456154352;5619.634723742944;4706.1528924793865;4723.197056500403;4798.688085274446;4811.7834697438;4820.276958456189;4086.468759061303;4136.255474014646;4137.627613514798;4161.334186530141;4168.437260969791;4926.679765815211;4936.827211047668;4947.233178857283;4955.677880937727;4989.600831933437;5610.887782244414;5739.799107031317;5778.94221057784;5783.624064435799;5785.218995435646;4857.757112144449;4907.779149938261;4981.501849814989;4988.351514303117;4999.950000499948;5100.7959681613065;5101.51535604117;5127.9230811537855;5128.974355128201;5156.845294641167;5326.121190003606;5386.892262154814;5387.515123638891;5403.6217464778665;5406.567474601944;5559.527440167631;5688.374278829243;5704.2014118024335;5793.159991801081;5805.419458054161;5402.027635025576;5418.810341638024;5420.566354691537;5443.972780136074;5483.259759932358;5666.235058267246;5701.714914254354;5704.80033198836;5707.571932105026;5712.143178523254;5631.408702086222;5713.800016999385;5724.599278050497;5789.681567513659;5810.244668193277;5624.184493248375;5638.295213098363;5640.774369025357;5669.518090962314;5682;5536.916946245729;5573.5819813513335;5588.972055139861;5611.214429979887;5613.354464236665;5368.892622147613;5452.645578037414;5484.396716361277;5499.807506737245;5558.090627727868;5517.255170552085;5557.638753481011;5596.524295434933;5607.383187849252;5626.662400255997;5409.107497262908;5475.288212532505;5483.232347471437;5487.067198576172;5487.533559647474 07:12:10 INFO - PID 32595 | |1;ext.html;728.1626129950557;742.458005655871;1035.0632677426927;1048.1614708233417;1182.3615247766206;32092.67907320929;32975.340493190124;32985;33171.83414082932;33208.33583328332;30566;30961.38077238454;31000.224994375152;31053.534196987006;31063.37873242534;6224.813255602327;6297.811065668015;6346.365363463639;6702.061711360413;6872.518923675345;6748.898766518481;6820.863582728342;6834.863302733942;6838.11104556407;6870.209925858515;6896.275891031445;6916.06633104532;6953.89569156463;6957.791266261995;6959.130108736408;6901.75843845468;6904.13698287714;6913.585184888922;6922.7923162305215;6929;6748.662566871686;6778.593284402902;6795.286494918061;6822.3859852613505;6832.111825462658;31118.37763244745;31135.688643113506;31278.37443251145;31294.843525782453;31408;2998.8050776699447;3016.4268788930035;3042.1481985044225;3063.9846800765854;3067.9539806902912;23961.640575391382;23983.88008059966;24012.759872401228;24089.156879509308;24118.517629647486;2778.2498725344244;2781.6383870096756;2803.215099772067;2804.3129433288773;2815.746582807557;142805.2859735705;143245.28377358048;143895.2805235967;144190.27904860408;144281.27859360742;37601.24797504034;39847.40228896569;39910;39993.400098998536;41254.58745412568;41767.37348939768;41854.04773093102;41873;42031.369529457086;43933.56066439359;10971.890281097087;11005.669829904955;11007.229493935347;11014.118870490342;11089.500972456259;8436.156384361515;8492.108328625529;8503.574821258911;8512.616932238065;8546.145385461405;13044.804327935088;13074.215547067206;13094.14888032275;13173.604791856067;13266.867331326755;5375.892482150335;5396.244525766318;5417.620766546304;5471.644343117685;5528.640638358494;870.0516437083609;904.2675432899241;912.3112050401904;931.6087243357806;954.3939598354956;19466;20037.499062523555;20237.08933098014;20863;21118.47203819917;974.498133461268;980.294188184506;981.2248323824242;984.9015098490237;1005.7787286796893;11108.222424430212;11118.666440006813;11225.943870280596;11226.7193320166;11253.831192532118;177355.11322443307;178379;178524.21475785077;178579;179796;40513.392299115534;40576.1884762309;40635.1872962545;40762.79618601888;40993.38509922354;1231.5627952076884;1255.5166260989402;1260.533602567056;1261.4449642157422;1282.58316047285;19309.51726206856;19877.204911803943;20000.69998950046;20333.085011174237;20693.27573534919;28943;29152;36502.45246321254;36938.076548086516;37455.625443745215;170484.1475792613;170489;171442.14278928525;171470;171643;29391.265218368855;29662.555061674524;29689.554656679735;29822.10533683993;29950.25124371908;34076;34671.47992780161;34719.4792078114;35116;35433;26745;26948.730512694623;27462.862685686443;27693.723062769113;28591.85704071466;26068.8696556516;26663.600045998937;27352.726472735812;27448.039318624553;28165.577516337682;29359.94480386438;29492;29889.402211956072;29921;29985.850070749508;26288.8685556571;26907.865460672572;27392.31519211956;27864.721352787023;28590.42819143564;18358.173882175066;19129.043547822832;19349.61300774005;19448;19464.902675486534 07:12:10 INFO - PID 32595 | |2;jquery.html;415.56780947814275;421.8481346715184;423.3882040451548;430.6705370391651;438.86614582552306;13955.860441395584;14823.18472484013;17047.232874520647;17679.911600441996;17688.292468301268;18171.727424088614;18387.26450941964;18539.72190417145;18548.350807721734;18585.907070464662;5355.169948657945;5427.565794736412;5446.428125046853;5520.641158324716;5620.4660557247;5505.559555235572;5600.18797274397;5606.159076138591;5611.438856114376;5613.691246981414;5213.296205012312;5408.8377348679405;5429.484199001088;5437.102878025121;5464.12573988162;5358.276632654581;5393.568514518829;5410.756515956791;5449.427810079964;5470.480304371078;4858.368412106439;4923.4091908970795;4928.926066109011;4943.752812359404;4945.505449455026;22302.55394892093;22333.553328933493;22635.886820565956;22648.660270095963;22876.54246915069;1594.4260066376096;1626.9674606507922;1632.126812155491;1633.199732131259;1634.9182540873028;14424.134551926812;14623.488177913829;14802.259887005606;14978.10131392109;15112.924435377863;2019.4042757386605;2110.947226319339;2136.391128528362;2149.4196566927;2155.073318473056;89439;93615.06384936132;96039;96141;96669;11049.668509944553;11196.720081998015;11289.266197697123;11370.886291137149;11606.651800446;15733.44932927342;15774.76337854933;15784.131872746879;15809.841901581067;15854.128022958848;7117.217106118323;7180.5691658500655;7346.816329591803;7418.443616728767;7458.477906546598;6377.8838703227675;6547.869042619216;6565.376289252514;6610.86778264432;6620.966895165589;7074.752383666547;7278.417726581861;7388.335049845432;7416.443766717518;7449.217832127657;2112.4613223627875;2130.20117455954;2142.957140857174;2154.838387120972;2224.0992398078806;865.952372619512;898.797770501645;901.4140808474544;905.8324210021167;931.9627214911328;16794.244259008374;17094.145292735564;17529.7370539442;17557.049663825535;17906.5523361917;872.2106493623281;894.592960203119;902.7562558109405;907.8138981508774;908.5139450394007;9248.537618000486;9469.195118414875;9749.317547771589;9770.75573110678;9835.213182945346;342263;343677;353496;355493;358614;74432;74646;77820.61089694516;78856;79217.04663031126;1037.3205550364523;1059.750958524746;1067.7597540553468;1068.1134658233648;1079.794838980591;15052.3226454812;15137.470188543348;15311;15320.693586127993;15657;35731.46402804012;36565.268694625425;36860.078498037765;36870.8156459216;37693.62306376901;46568.301475477216;46660.300095499275;47158.76420617875;47386;47437.76281118573;7829;7939.166387529457;7968.721094761656;8122.959385203036;8494.193051660082;12193.268403895794;12640.494380225056;12737.745245095231;12894.290814004944;13274.80087798703;10514.421706806199;11055.336679799238;11365.147613928822;11556;11706;10341.63804266847;10492.895071049192;10514.158867290751;10633.361998280128;11198.664040078811;11130.554777808797;11418.600348987746;11528.769424611628;11651.242669226473;12102.213356131822;8584.442011269248;8646.308295336485;8663.133686631287;8806.91193088061;8818.29453643694;10731.40977246259;10798.892011079788;10892.40091794959;10906.400147991937;11105.944470277596 07:12:10 INFO - PID 32595 | |3;mootools.html;1257.46557712972;1311.114997376771;1315.2174456198559;1315.9407826647794;1328.5615746803555;9271.860922086165;9652.131308182263;9678.951605241973;9783.070608292219;10016.599336026551;9669.323147379686;9854.359466634663;9861.457619830924;9866.950665246683;9889.802203955916;2119.1311562259475;2146.0986385717956;2148;2151.8924053797327;2152.4080877758583;2120.9893950530304;2177.640689286266;2189.638709612912;2190.452386903274;2196.5936301784222;2101.831853451728;2112.0601332407086;2131.9253826116087;2156.870587764731;2158.985276919845;2128.7871212878745;2180.3349978256624;2182.410749097751;2187.55155193185;2189.1571744878256;2044.6626306659532;2113.936581902545;2157.471419502216;2161.492049368397;2176.3906106290265;9630.3258771886;9687.079727425884;9707.951460242724;9710.514474276328;9715.514224288829;5124.666896651743;5306.92039619406;5315.813946511892;5341.092014357569;5342;3228.2413632796274;3266.6586625045024;3355.580552430946;3422.743294252941;3436.60479044908;1093.5899037860802;1116.916231282657;1122.2929554380687;1171.4201470272185;1190.321516735461;13513.86486135136;13699.794503082361;13778.311084445737;13820.447182112703;13855.445782168801;4562.771861406916;4715.434147902273;4955.776990035457;4997.575206107522;5009.599232061426;9766.706998790047;9789.706308810748;9836.311458198;9836.508174591241;9850.113489785954;5020.297158397827;5038.874028149326;5053.090443720165;5093.490650934951;5110.923336149961;4502.347159661831;4545.31820226962;4576.450825900846;4645.163870503275;4664.253719404879;3738.7569807962395;3784.5836957934607;3895.104126051024;3921.627445392683;4030.2946984277633;1114.793763153819;1117.8658560972735;1123.393367581497;1125.3641692443744;1144.490701637763;633.7655067625009;653.180258775234;677.4005005570008;678.6878036103448;682.0928165539821;5088.414832294259;5187.714675692798;5247.396549396792;5255.290535777697;5346.492083252085;545.9000114768744;565.0366125755577;568.5196009372074;569.9287589051369;576.6972339521701;3259.1200375898848;3264.9836750816094;3312.519684645761;3327.600687917417;3369.578802649669;11676.357800320893;12113.75772484563;12289.56986505468;12435.44040518179;12462.875371246171;12191.72126354928;12278.324692142018;12439.37803109841;12504.937475312565;12522.311272880079;7071.398931090812;7230.240824713434;7275.963620181971;7295.598742069237;7331.596762178131;5424;5646.689432081275;5723.828285151452;5749.13762935563;5811.331696854747;10596.152307815202;10945.56217751313;11049.116070714163;11055.391953442639;11060;11104.611338603434;11145.49845256949;11240.213185076966;11305.684174926857;11424.942875285571;7166.605836678824;7260.237675044255;7326.157491888501;7328.890066649111;7330.45021623391;8295.211954864279;8306.377021723274;8368.20502052304;8401.621927013177;8426.368022398467;7285.089363829521;7420.740274090381;7509.399248060033;7518.436117291116;7660.080790305199;7134.286571342825;7190.71237150529;7211.71153153868;7263.273672632695;7326.120865495961;6865.519413640997;6880.105586273952;7009.439244860501;7100.467464940047;7165.462590305644;5041.823536176216;5103.8468845934685;5153.6907785532985;5172.379314482287;5183.092958732283;5040.49595040493;5073.315102461121;5100.158473851773;5196.194589838581;5278.577713782965 07:12:10 INFO - PID 32595 | |4;prototype.html;351.6624040920716;364.7738402190642;368.99999999999983;388.08605733497615;390.2254025758869;5587.636803607763;5588.748506317215;5610;5611.130274807406;5619.241402410678;5481.205225242337;5493.945060549393;5497.5601951843855;5497.945020549803;5506.1190209566375;4169.499660040799;4198.286291330466;4241.384999175118;4261.659067274619;4266.168097221043;4238.724482908617;4247.3223076884615;4249.1714115747445;4258.97870510647;4270.121146695459;4232.238197124517;4233.089885674579;4233.491980962289;4243.384709217162;4244.448221731186;4175;4229.577042295777;4236.04688944988;4238.131183107471;4249.851255206068;3748.306563285801;3762.1347090169143;3763.5107436033413;3764.6800021998165;3786.5266841644793;5244.947550524484;5267;5276.894462110775;5281.471852814726;5283.916797056594;4928.01439712059;4988.825391111293;5000.849634657096;5023.422306434733;5031.496850314976;5773.509251713609;5818.156367326714;5822.97088514559;5847.386024467455;5870;4154.91690166195;4206.137741762962;4209.65291106846;4225.112726327475;4227.091175397304;5622.943770562283;6020.367861374581;6034.849128771772;6073.878522429527;6091.878162436771;4054;4095;4100.282450571138;4105.67154627629;4115.814788334532;4179.352200408942;4182.749035057906;4184.267753143188;4185.916281674349;4195.832166713297;4679.853231836907;4830.903381932341;4831.589314908202;4832.782524786393;4835.927461088087;5773.480386765212;5790.942090579125;5820.88358232833;5829.88340233193;5835.562332825055;1419.1910610951866;1439.165284135199;1439.755241608929;1440.985590144085;1443.631873872156;910.7495438754396;949.5489642419795;960.7165886063628;970.5001924009141;974.7611835100304;5082.1360368737405;5094.083065048327;5095.286659867622;5098.97450512745;5129.948700513021;6072.7570897164505;6080.513558915276;6083.39166083397;6084.665343406066;6085.421884920926;4894.143524883131;5069.239614057921;5087.592992560586;5091.87270318245;5105.821296254688;3169.397814415254;3197.8720851165695;3202.7580693514633;3203.3913556424673;3208.98395508021;5450.945490545123;5693.516051135617;5693.772249110072;5695;5721.22763426932;6056.152138700585;6158.445739883342;6173.715725181622;6208;6217.751289948352;5685.573581981368;5700.118960742945;5704.602372418784;5715.914261286167;5723.799667011801;5999.88000239984;6033.879322413615;6085.421884920926;6095.9390406097145;6121.357257488078;5916.698326368192;5965.642061476326;5968.76124954997;5973.522118230618;5987;5660.150977353265;5679.176519404746;5682.925732107668;5692.914606280826;5703.828885133453;3984.744805386294;4064.5122585289955;4108.301588729863;4113.341865301538;4114.958850411457;6041.969790151021;6053.939460605337;6072.787452439144;6077.726502307319;6087.847803804941;5706.80026199081;5848.502877255481;5848.590598658223;5861.9706901465215;5871.588988770745;5783.450572195635;5812.738426770721;5839.328477225004;5845.970770146122;5859.531237501075;5730.255066841284;5734.397888221677;5738.885222295614;5744.195812586157;5793.971030144822;5715.542756579547;5761.251037365116;5857.26784151981;5858.736356864037;5891.675957822361;5672.943270567242;5673.120666296731;5677.858053548529;5712.400197979152;5719.342275638355 07:12:10 INFO - PID 32595 | |5;yui.html;649.2922714241482;652.494316904399;721.4444877444367;730.6821532633305;752.3229093815565;13475.865241347583;13936.860631393696;13962.790558141636;15772.290246938886;17204.39784607539;16057.678846423094;16302.184890755474;16346.10096444695;16401;16922.661546769086;893.5398269890995;905.7871400220943;909.549772862434;910.1444642036498;911.0980129671643;884.5400391796262;898.9595468203914;900.0369604523163;904.760238536785;905.6603773584906;948.5257371314343;957.3633533700081;958.1616085924816;959;960.255801753643;938.6761567259318;943.6461327002374;947.5499137909507;948.127722495299;952.3190918493241;696.7839969609387;697.891826766852;699.7655785311927;700.5796522086758;704.4082970304969;14765.483208087773;14832.184229867353;14836.851631483654;14849.257537123101;15392.538223853302;16176.191190440431;16180.595485112848;16479.91760041204;16536.66926661472;16701.66596668072;12340.197887137307;12490.625281241486;12656.430460629294;12735.044871634573;12871.742565148737;2761.4891245119716;2773.251222170023;2788.9023884164158;2792.762615177692;2796.314902848815;72714;74777.5044499107;74935.25064749338;75730.62134689401;76625.61687191584;12643.367831608566;12737.299448530235;12753.744925101446;12756;12766.80849787254;22678.319650410514;22918.197863075045;23183.76816231816;23365;23385.766142338358;6073.726682299307;6095.451409373178;6329.905051424233;6339.080833279241;6345.0482427636225;3030.9696903030685;3049.4510988021925;3066.601341825593;3088.1970687620933;3102.8913988010313;3324.9335013299597;3426.811525366129;3446.4485682290715;3448.4310088835564;3452.6202117767025;638.52748965765;645.7255666341786;649.1885143570537;650.1710319342876;652.2336254900473;571.7970120607208;580.6254965547283;582.8226981497352;588.2881713127078;600.9579329446897;8495.856533082675;8640.222379985831;8652.586446464747;8924.196822286025;9146.95426522863;522.4749127127288;535.5046581911716;537.1539824775994;549.4395716369281;551.1209620655048;4017.879463616096;4032.8185231664647;4068.816903239361;4081.428599996003;4086.1827634473225;60753.39246607566;60931.6953415239;61306.693466533274;62740.37259627345;63811.680941595;48973.265401019016;50241.748791255806;50777.238341424905;51017;57302.14046789301;46177.30734038992;46485.5351446488;47132;47134;47872.760636197294;9203.217726493323;9356.719298421058;9461;9645.035496450579;9872.851907221253;24314.63528047116;25327.620085699098;25366.746332536437;25387.61918571186;26039;30728.078157655305;41975.58024419717;43632.34551481667;43650.12699746051;44933.10133797371;13011.414486347947;13063.608091757262;13181;13191.472341106632;13281.535146269835;13651.11267767592;13661.316934153452;13738.931305343409;13825.377857996615;13863;12342.259464432163;12519.874801251872;12656;12781.105322627327;12788.616341509769;13299.20204787716;13603.863961360259;13694.726105477635;13802.585922422344;13979.790303145257;12276.631701048982;12414.813777793159;12544.937275313565;12555;12643.936780316408;9688.806223875625;9747.902520974983;9986.300958933096;10067.748306292402;10104.545295461576;9801.36291141102;10020.198384129106;10208.081272685495;10325.586976520855;10340.638077667245 07:12:10 INFO - PID 32595 | __end_tp_report 07:12:10 INFO - PID 32595 | __start_cc_report 07:12:10 INFO - PID 32595 | _x_x_mozilla_cycle_collect,335 07:12:10 INFO - PID 32595 | __end_cc_report 07:12:10 INFO - PID 32595 | __startTimestamp1493993530870__endTimestamp 07:12:10 INFO - PID 32595 | 07:12:10 INFO - PID 32595 | ------- Summary: start ------- 07:12:10 INFO - PID 32595 | Number of tests: 6 07:12:10 INFO - PID 32595 | 07:12:10 INFO - PID 32595 | [#0] dojo.html Cycles:165 Average:5252.04 Median:5420.57 stddev:610.86 (11.3%) stddev-sans-first:580.46 07:12:10 INFO - PID 32595 | Values: 2754.3 2781.1 2802.7 2813.5 2824.8 5223.3 5355.2 5370.1 5397.7 5414.4 5263.3 5329.6 5349.4 5425.0 5454.2 4443.3 4712.4 4715.7 4730.0 4758.0 4774.7 4794.2 4814.8 4825.9 4832.9 4584.2 4665.1 4699.3 4763.5 4792.6 4775.5 4780.8 4780.9 4799.5 4835.7 4734.4 4736.4 4766.8 4768.6 4797.3 5080.1 5157.8 5171.4 5237.4 5284.9 5741.1 5753.6 5755.1 5782.2 5816.1 5756.8 5773.6 5776.1 5779.5 5781.7 5188.6 5260.2 5332.7 5335.2 5335.9 5747.0 5875.6 5881.9 5889.9 5893.9 5631.4 5694.5 5701.4 5725.9 5752.8 5734.7 5785.7 5795.9 5795.9 5818.2 5576.6 5660.4 5757.2 5775.3 5782.7 5590.6 5599.7 5604.2 5615.4 5619.6 4706.2 4723.2 4798.7 4811.8 4820.3 4086.5 4136.3 4137.6 4161.3 4168.4 4926.7 4936.8 4947.2 4955.7 4989.6 5610.9 5739.8 5778.9 5783.6 5785.2 4857.8 4907.8 4981.5 4988.4 5000.0 5100.8 5101.5 5127.9 5129.0 5156.8 5326.1 5386.9 5387.5 5403.6 5406.6 5559.5 5688.4 5704.2 5793.2 5805.4 5402.0 5418.8 5420.6 5444.0 5483.3 5666.2 5701.7 5704.8 5707.6 5712.1 5631.4 5713.8 5724.6 5789.7 5810.2 5624.2 5638.3 5640.8 5669.5 5682.0 5536.9 5573.6 5589.0 5611.2 5613.4 5368.9 5452.6 5484.4 5499.8 5558.1 5517.3 5557.6 5596.5 5607.4 5626.7 5409.1 5475.3 5483.2 5487.1 5487.5 07:12:10 INFO - PID 32595 | 07:12:10 INFO - PID 32595 | [#1] ext.html Cycles:180 Average:30497.17 Median:16492.33 stddev:42697.26 (258.9%) stddev-sans-first:42758.52 07:12:10 INFO - PID 32595 | Values: 728.2 742.5 1035.1 1048.2 1182.4 32092.7 32975.3 32985.0 33171.8 33208.3 30566.0 30961.4 31000.2 31053.5 31063.4 6224.8 6297.8 6346.4 6702.1 6872.5 6748.9 6820.9 6834.9 6838.1 6870.2 6896.3 6916.1 6953.9 6957.8 6959.1 6901.8 6904.1 6913.6 6922.8 6929.0 6748.7 6778.6 6795.3 6822.4 6832.1 31118.4 31135.7 31278.4 31294.8 31408.0 2998.8 3016.4 3042.1 3064.0 3068.0 23961.6 23983.9 24012.8 24089.2 24118.5 2778.2 2781.6 2803.2 2804.3 2815.7 142805.3 143245.3 143895.3 144190.3 144281.3 37601.2 39847.4 39910.0 39993.4 41254.6 41767.4 41854.0 41873.0 42031.4 43933.6 10971.9 11005.7 11007.2 11014.1 11089.5 8436.2 8492.1 8503.6 8512.6 8546.1 13044.8 13074.2 13094.1 13173.6 13266.9 5375.9 5396.2 5417.6 5471.6 5528.6 870.1 904.3 912.3 931.6 954.4 19466.0 20037.5 20237.1 20863.0 21118.5 974.5 980.3 981.2 984.9 1005.8 11108.2 11118.7 11225.9 11226.7 11253.8 177355.1 178379.0 178524.2 178579.0 179796.0 40513.4 40576.2 40635.2 40762.8 40993.4 1231.6 1255.5 1260.5 1261.4 1282.6 19309.5 19877.2 20000.7 20333.1 20693.3 28943.0 29152.0 36502.5 36938.1 37455.6 170484.1 170489.0 171442.1 171470.0 171643.0 29391.3 29662.6 29689.6 29822.1 29950.3 34076.0 34671.5 34719.5 35116.0 35433.0 26745.0 26948.7 27462.9 27693.7 28591.9 26068.9 26663.6 27352.7 27448.0 28165.6 29359.9 29492.0 29889.4 29921.0 29985.9 26288.9 26907.9 27392.3 27864.7 28590.4 18358.2 19129.0 19349.6 19448.0 19464.9 07:12:10 INFO - PID 32595 | 07:12:10 INFO - PID 32595 | [#2] jquery.html Cycles:180 Average:24396.45 Median:197589.63 stddev:58726.58 (29.7%) stddev-sans-first:58863.72 07:12:10 INFO - PID 32595 | Values: 415.6 421.8 423.4 430.7 438.9 13955.9 14823.2 17047.2 17679.9 17688.3 18171.7 18387.3 18539.7 18548.4 18585.9 5355.2 5427.6 5446.4 5520.6 5620.5 5505.6 5600.2 5606.2 5611.4 5613.7 5213.3 5408.8 5429.5 5437.1 5464.1 5358.3 5393.6 5410.8 5449.4 5470.5 4858.4 4923.4 4928.9 4943.8 4945.5 22302.6 22333.6 22635.9 22648.7 22876.5 1594.4 1627.0 1632.1 1633.2 1634.9 14424.1 14623.5 14802.3 14978.1 15112.9 2019.4 2110.9 2136.4 2149.4 2155.1 89439.0 93615.1 96039.0 96141.0 96669.0 11049.7 11196.7 11289.3 11370.9 11606.7 15733.4 15774.8 15784.1 15809.8 15854.1 7117.2 7180.6 7346.8 7418.4 7458.5 6377.9 6547.9 6565.4 6610.9 6621.0 7074.8 7278.4 7388.3 7416.4 7449.2 2112.5 2130.2 2143.0 2154.8 2224.1 866.0 898.8 901.4 905.8 932.0 16794.2 17094.1 17529.7 17557.0 17906.6 872.2 894.6 902.8 907.8 908.5 9248.5 9469.2 9749.3 9770.8 9835.2 342263.0 343677.0 353496.0 355493.0 358614.0 74432.0 74646.0 77820.6 78856.0 79217.0 1037.3 1059.8 1067.8 1068.1 1079.8 15052.3 15137.5 15311.0 15320.7 15657.0 35731.5 36565.3 36860.1 36870.8 37693.6 46568.3 46660.3 47158.8 47386.0 47437.8 7829.0 7939.2 7968.7 8123.0 8494.2 12193.3 12640.5 12737.7 12894.3 13274.8 10514.4 11055.3 11365.1 11556.0 11706.0 10341.6 10492.9 10514.2 10633.4 11198.7 11130.6 11418.6 11528.8 11651.2 12102.2 8584.4 8646.3 8663.1 8806.9 8818.3 10731.4 10798.9 10892.4 10906.4 11105.9 07:12:10 INFO - PID 32595 | 07:12:10 INFO - PID 32595 | [#3] mootools.html Cycles:180 Average:5864.87 Median:5014.95 stddev:3691.00 (73.6%) stddev-sans-first:3685.12 07:12:10 INFO - PID 32595 | Values: 1257.5 1311.1 1315.2 1315.9 1328.6 9271.9 9652.1 9679.0 9783.1 10016.6 9669.3 9854.4 9861.5 9867.0 9889.8 2119.1 2146.1 2148.0 2151.9 2152.4 2121.0 2177.6 2189.6 2190.5 2196.6 2101.8 2112.1 2131.9 2156.9 2159.0 2128.8 2180.3 2182.4 2187.6 2189.2 2044.7 2113.9 2157.5 2161.5 2176.4 9630.3 9687.1 9708.0 9710.5 9715.5 5124.7 5306.9 5315.8 5341.1 5342.0 3228.2 3266.7 3355.6 3422.7 3436.6 1093.6 1116.9 1122.3 1171.4 1190.3 13513.9 13699.8 13778.3 13820.4 13855.4 4562.8 4715.4 4955.8 4997.6 5009.6 9766.7 9789.7 9836.3 9836.5 9850.1 5020.3 5038.9 5053.1 5093.5 5110.9 4502.3 4545.3 4576.5 4645.2 4664.3 3738.8 3784.6 3895.1 3921.6 4030.3 1114.8 1117.9 1123.4 1125.4 1144.5 633.8 653.2 677.4 678.7 682.1 5088.4 5187.7 5247.4 5255.3 5346.5 545.9 565.0 568.5 569.9 576.7 3259.1 3265.0 3312.5 3327.6 3369.6 11676.4 12113.8 12289.6 12435.4 12462.9 12191.7 12278.3 12439.4 12504.9 12522.3 7071.4 7230.2 7276.0 7295.6 7331.6 5424.0 5646.7 5723.8 5749.1 5811.3 10596.2 10945.6 11049.1 11055.4 11060.0 11104.6 11145.5 11240.2 11305.7 11424.9 7166.6 7260.2 7326.2 7328.9 7330.5 8295.2 8306.4 8368.2 8401.6 8426.4 7285.1 7420.7 7509.4 7518.4 7660.1 7134.3 7190.7 7211.7 7263.3 7326.1 6865.5 6880.1 7009.4 7100.5 7165.5 5041.8 5103.8 5153.7 5172.4 5183.1 5040.5 5073.3 5100.2 5196.2 5278.6 07:12:10 INFO - PID 32595 | 07:12:10 INFO - PID 32595 | [#4] prototype.html Cycles:180 Average:4817.88 Median:5546.88 stddev:1424.59 (25.7%) stddev-sans-first:1388.58 07:12:10 INFO - PID 32595 | Values: 351.7 364.8 369.0 388.1 390.2 5587.6 5588.7 5610.0 5611.1 5619.2 5481.2 5493.9 5497.6 5497.9 5506.1 4169.5 4198.3 4241.4 4261.7 4266.2 4238.7 4247.3 4249.2 4259.0 4270.1 4232.2 4233.1 4233.5 4243.4 4244.4 4175.0 4229.6 4236.0 4238.1 4249.9 3748.3 3762.1 3763.5 3764.7 3786.5 5244.9 5267.0 5276.9 5281.5 5283.9 4928.0 4988.8 5000.8 5023.4 5031.5 5773.5 5818.2 5823.0 5847.4 5870.0 4154.9 4206.1 4209.7 4225.1 4227.1 5622.9 6020.4 6034.8 6073.9 6091.9 4054.0 4095.0 4100.3 4105.7 4115.8 4179.4 4182.7 4184.3 4185.9 4195.8 4679.9 4830.9 4831.6 4832.8 4835.9 5773.5 5790.9 5820.9 5829.9 5835.6 1419.2 1439.2 1439.8 1441.0 1443.6 910.7 949.5 960.7 970.5 974.8 5082.1 5094.1 5095.3 5099.0 5129.9 6072.8 6080.5 6083.4 6084.7 6085.4 4894.1 5069.2 5087.6 5091.9 5105.8 3169.4 3197.9 3202.8 3203.4 3209.0 5450.9 5693.5 5693.8 5695.0 5721.2 6056.2 6158.4 6173.7 6208.0 6217.8 5685.6 5700.1 5704.6 5715.9 5723.8 5999.9 6033.9 6085.4 6095.9 6121.4 5916.7 5965.6 5968.8 5973.5 5987.0 5660.2 5679.2 5682.9 5692.9 5703.8 3984.7 4064.5 4108.3 4113.3 4115.0 6042.0 6053.9 6072.8 6077.7 6087.8 5706.8 5848.5 5848.6 5862.0 5871.6 5783.5 5812.7 5839.3 5846.0 5859.5 5730.3 5734.4 5738.9 5744.2 5794.0 5715.5 5761.3 5857.3 5858.7 5891.7 5672.9 5673.1 5677.9 5712.4 5719.3 07:12:10 INFO - PID 32595 | 07:12:10 INFO - PID 32595 | [#5] yui.html Cycles:180 Average:15091.62 Median:4083.81 stddev:18037.41 (441.7%) stddev-sans-first:18055.41 07:12:10 INFO - PID 32595 | Values: 649.3 652.5 721.4 730.7 752.3 13475.9 13936.9 13962.8 15772.3 17204.4 16057.7 16302.2 16346.1 16401.0 16922.7 893.5 905.8 909.5 910.1 911.1 884.5 899.0 900.0 904.8 905.7 948.5 957.4 958.2 959.0 960.3 938.7 943.6 947.5 948.1 952.3 696.8 697.9 699.8 700.6 704.4 14765.5 14832.2 14836.9 14849.3 15392.5 16176.2 16180.6 16479.9 16536.7 16701.7 12340.2 12490.6 12656.4 12735.0 12871.7 2761.5 2773.3 2788.9 2792.8 2796.3 72714.0 74777.5 74935.3 75730.6 76625.6 12643.4 12737.3 12753.7 12756.0 12766.8 22678.3 22918.2 23183.8 23365.0 23385.8 6073.7 6095.5 6329.9 6339.1 6345.0 3031.0 3049.5 3066.6 3088.2 3102.9 3324.9 3426.8 3446.4 3448.4 3452.6 638.5 645.7 649.2 650.2 652.2 571.8 580.6 582.8 588.3 601.0 8495.9 8640.2 8652.6 8924.2 9147.0 522.5 535.5 537.2 549.4 551.1 4017.9 4032.8 4068.8 4081.4 4086.2 60753.4 60931.7 61306.7 62740.4 63811.7 48973.3 50241.7 50777.2 51017.0 57302.1 46177.3 46485.5 47132.0 47134.0 47872.8 9203.2 9356.7 9461.0 9645.0 9872.9 24314.6 25327.6 25366.7 25387.6 26039.0 30728.1 41975.6 43632.3 43650.1 44933.1 13011.4 13063.6 13181.0 13191.5 13281.5 13651.1 13661.3 13738.9 13825.4 13863.0 12342.3 12519.9 12656.0 12781.1 12788.6 13299.2 13603.9 13694.7 13802.6 13979.8 12276.6 12414.8 12544.9 12555.0 12643.9 9688.8 9747.9 9986.3 10067.7 10104.5 9801.4 10020.2 10208.1 10325.6 10340.6 07:12:10 INFO - PID 32595 | -------- Summary: end -------- 07:12:10 INFO - PID 32595 | 07:12:11 INFO - TEST-INFO | 32595: exit 0 07:12:11 INFO - TEST-OK | dromaeo_css | took 1119584ms 07:12:11 INFO - TEST-START | kraken 07:12:11 INFO - operating with platform_type : linux_ 07:12:11 INFO - Initialising browser for kraken test... 07:12:11 INFO - TEST-INFO | started process 567 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpahmIax/profile http://localhost:33864/getInfo.html) 07:12:15 INFO - PID 567 | __metrics Screen width/height:1600/1200 07:12:15 INFO - PID 567 | colorDepth:24 07:12:15 INFO - PID 567 | Browser inner width/height: 1024/695 07:12:15 INFO - PID 567 | __metrics 07:12:17 INFO - TEST-INFO | 567: exit 0 07:12:17 INFO - Browser initialized. 07:12:17 INFO - Running cycle 1/1 for kraken test... 07:12:17 INFO - TEST-INFO | started process 761 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpahmIax/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:12:29 INFO - PID 761 | RSS: Main: 173297664 07:12:29 INFO - PID 761 | 07:12:32 INFO - PID 761 | Cycle 1(1): loaded http://localhost:33864/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33864/tests/kraken/driver.html?testName=audio-beat-detection) 07:12:33 INFO - PID 761 | RSS: Main: 182300672 07:12:33 INFO - PID 761 | 07:12:36 INFO - PID 761 | Cycle 1(1): loaded http://localhost:33864/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33864/tests/kraken/driver.html?testName=audio-dft) 07:12:36 INFO - PID 761 | RSS: Main: 181411840 07:12:36 INFO - PID 761 | 07:12:39 INFO - PID 761 | Cycle 1(1): loaded http://localhost:33864/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33864/tests/kraken/driver.html?testName=audio-fft) 07:12:40 INFO - PID 761 | RSS: Main: 177790976 07:12:40 INFO - PID 761 | 07:12:42 INFO - PID 761 | Cycle 1(1): loaded http://localhost:33864/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33864/tests/kraken/driver.html?testName=audio-oscillator) 07:12:42 INFO - PID 761 | RSS: Main: 178671616 07:12:42 INFO - PID 761 | 07:12:45 INFO - PID 761 | Cycle 1(1): loaded http://localhost:33864/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33864/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:12:45 INFO - PID 761 | RSS: Main: 178741248 07:12:45 INFO - PID 761 | 07:12:48 INFO - PID 761 | Cycle 1(1): loaded http://localhost:33864/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33864/tests/kraken/driver.html?testName=imaging-darkroom) 07:12:49 INFO - PID 761 | RSS: Main: 182718464 07:12:49 INFO - PID 761 | 07:12:52 INFO - PID 761 | Cycle 1(1): loaded http://localhost:33864/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33864/tests/kraken/driver.html?testName=imaging-desaturate) 07:12:53 INFO - PID 761 | RSS: Main: 180854784 07:12:53 INFO - PID 761 | 07:12:56 INFO - PID 761 | Cycle 1(1): loaded http://localhost:33864/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33864/tests/kraken/driver.html?testName=json-parse-financial) 07:12:57 INFO - PID 761 | RSS: Main: 182104064 07:12:57 INFO - PID 761 | 07:12:58 INFO - PID 761 | Cycle 1(1): loaded http://localhost:33864/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33864/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:12:59 INFO - PID 761 | RSS: Main: 182386688 07:12:59 INFO - PID 761 | 07:13:01 INFO - PID 761 | Cycle 1(1): loaded http://localhost:33864/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33864/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:13:01 INFO - PID 761 | RSS: Main: 183468032 07:13:01 INFO - PID 761 | 07:13:03 INFO - PID 761 | Cycle 1(1): loaded http://localhost:33864/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33864/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:13:04 INFO - PID 761 | RSS: Main: 183721984 07:13:04 INFO - PID 761 | 07:13:07 INFO - PID 761 | Cycle 1(1): loaded http://localhost:33864/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33864/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:13:08 INFO - PID 761 | RSS: Main: 183590912 07:13:08 INFO - PID 761 | 07:13:11 INFO - PID 761 | Cycle 1(1): loaded http://localhost:33864/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33864/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:13:11 INFO - PID 761 | RSS: Main: 183459840 07:13:11 INFO - PID 761 | 07:13:13 INFO - PID 761 | Cycle 1(1): loaded http://localhost:33864/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33864/tests/kraken/driver.html?testName=ai-astar) 07:13:13 INFO - PID 761 | RSS: Main: 185782272 07:13:13 INFO - PID 761 | 07:13:13 INFO - PID 761 | __start_tp_report 07:13:13 INFO - PID 761 | _x_x_mozilla_page_load 07:13:13 INFO - PID 761 | _x_x_mozilla_page_load_details 07:13:13 INFO - PID 761 | |i|pagename|runs| 07:13:13 INFO - PID 761 | |0;ai-astar;103;113;112;113;113;111;113;112;111;111 07:13:13 INFO - PID 761 | |1;audio-beat-detection;152;130;125;164;124;122;124;124;144;123 07:13:13 INFO - PID 761 | |2;audio-dft;163;165;164;167;170;180;165;166;164;164 07:13:13 INFO - PID 761 | |3;audio-fft;75;76;75;111;74;74;75;74;93;79 07:13:13 INFO - PID 761 | |4;audio-oscillator;83;83;108;84;82;83;96;83;83;111 07:13:13 INFO - PID 761 | |5;imaging-gaussian-blur;115;114;113;114;114;114;113;118;115;114 07:13:13 INFO - PID 761 | |6;imaging-darkroom;149;151;150;151;150;150;149;150;152;150 07:13:13 INFO - PID 761 | |7;imaging-desaturate;94;95;94;94;94;95;94;95;94;94 07:13:13 INFO - PID 761 | |8;json-parse-financial;56;55;53;54;54;55;56;55;55;55 07:13:13 INFO - PID 761 | |9;json-stringify-tinderbox;55;56;56;55;55;55;55;56;56;56 07:13:13 INFO - PID 761 | |10;stanford-crypto-aes;90;82;82;81;92;84;83;81;84;83 07:13:13 INFO - PID 761 | |11;stanford-crypto-ccm;141;135;146;129;129;137;141;130;231;129 07:13:13 INFO - PID 761 | |12;stanford-crypto-pbkdf2;181;186;191;186;186;178;183;193;186;186 07:13:13 INFO - PID 761 | |13;stanford-crypto-sha256-iterative;70;73;70;71;72;70;69;70;69;70 07:13:13 INFO - PID 761 | __end_tp_report 07:13:13 INFO - PID 761 | __start_cc_report 07:13:13 INFO - PID 761 | _x_x_mozilla_cycle_collect,833 07:13:13 INFO - PID 761 | __end_cc_report 07:13:13 INFO - PID 761 | __startTimestamp1493993593964__endTimestamp 07:13:13 INFO - PID 761 | 07:13:13 INFO - PID 761 | ------- Summary: start ------- 07:13:13 INFO - PID 761 | Number of tests: 14 07:13:13 INFO - PID 761 | 07:13:13 INFO - PID 761 | [#0] ai-astar Cycles:10 Average:111.20 Median:112.50 stddev:3.01 (2.7%) stddev-sans-first:0.93 07:13:13 INFO - PID 761 | Values: 103.0 113.0 112.0 113.0 113.0 111.0 113.0 112.0 111.0 111.0 07:13:13 INFO - PID 761 | 07:13:13 INFO - PID 761 | [#1] audio-beat-detection Cycles:10 Average:133.20 Median:127.50 stddev:14.83 (11.6%) stddev-sans-first:14.08 07:13:13 INFO - PID 761 | Values: 152.0 130.0 125.0 164.0 124.0 122.0 124.0 124.0 144.0 123.0 07:13:13 INFO - PID 761 | 07:13:13 INFO - PID 761 | [#2] audio-dft Cycles:10 Average:166.80 Median:165.50 stddev:5.05 (3.1%) stddev-sans-first:5.17 07:13:13 INFO - PID 761 | Values: 163.0 165.0 164.0 167.0 170.0 180.0 165.0 166.0 164.0 164.0 07:13:13 INFO - PID 761 | 07:13:13 INFO - PID 761 | [#3] audio-fft Cycles:10 Average:80.60 Median:75.00 stddev:12.14 (16.2%) stddev-sans-first:12.71 07:13:13 INFO - PID 761 | Values: 75.0 76.0 75.0 111.0 74.0 74.0 75.0 74.0 93.0 79.0 07:13:13 INFO - PID 761 | 07:13:13 INFO - PID 761 | [#4] audio-oscillator Cycles:10 Average:89.60 Median:83.00 stddev:11.28 (13.6%) stddev-sans-first:11.70 07:13:13 INFO - PID 761 | Values: 83.0 83.0 108.0 84.0 82.0 83.0 96.0 83.0 83.0 111.0 07:13:13 INFO - PID 761 | 07:13:13 INFO - PID 761 | [#5] imaging-gaussian-blur Cycles:10 Average:114.40 Median:114.00 stddev:1.43 (1.3%) stddev-sans-first:1.50 07:13:13 INFO - PID 761 | Values: 115.0 114.0 113.0 114.0 114.0 114.0 113.0 118.0 115.0 114.0 07:13:13 INFO - PID 761 | 07:13:13 INFO - PID 761 | [#6] imaging-darkroom Cycles:10 Average:150.20 Median:150.00 stddev:0.92 (0.6%) stddev-sans-first:0.87 07:13:13 INFO - PID 761 | Values: 149.0 151.0 150.0 151.0 150.0 150.0 149.0 150.0 152.0 150.0 07:13:13 INFO - PID 761 | 07:13:13 INFO - PID 761 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 07:13:13 INFO - PID 761 | Values: 94.0 95.0 94.0 94.0 94.0 95.0 94.0 95.0 94.0 94.0 07:13:13 INFO - PID 761 | 07:13:13 INFO - PID 761 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:55.00 stddev:0.92 (1.7%) stddev-sans-first:0.87 07:13:13 INFO - PID 761 | Values: 56.0 55.0 53.0 54.0 54.0 55.0 56.0 55.0 55.0 55.0 07:13:13 INFO - PID 761 | 07:13:13 INFO - PID 761 | [#9] json-stringify-tinderbox Cycles:10 Average:55.50 Median:56.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 07:13:13 INFO - PID 761 | Values: 55.0 56.0 56.0 55.0 55.0 55.0 55.0 56.0 56.0 56.0 07:13:13 INFO - PID 761 | 07:13:13 INFO - PID 761 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:83.50 stddev:3.77 (4.5%) stddev-sans-first:3.36 07:13:13 INFO - PID 761 | Values: 90.0 82.0 82.0 81.0 92.0 84.0 83.0 81.0 84.0 83.0 07:13:13 INFO - PID 761 | 07:13:13 INFO - PID 761 | [#11] stanford-crypto-ccm Cycles:10 Average:144.80 Median:139.00 stddev:30.89 (22.2%) stddev-sans-first:32.73 07:13:13 INFO - PID 761 | Values: 141.0 135.0 146.0 129.0 129.0 137.0 141.0 130.0 231.0 129.0 07:13:13 INFO - PID 761 | 07:13:13 INFO - PID 761 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.60 Median:186.00 stddev:4.35 (2.3%) stddev-sans-first:4.28 07:13:13 INFO - PID 761 | Values: 181.0 186.0 191.0 186.0 186.0 178.0 183.0 193.0 186.0 186.0 07:13:13 INFO - PID 761 | 07:13:13 INFO - PID 761 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:70.00 stddev:1.26 (1.8%) stddev-sans-first:1.33 07:13:13 INFO - PID 761 | Values: 70.0 73.0 70.0 71.0 72.0 70.0 69.0 70.0 69.0 70.0 07:13:13 INFO - PID 761 | -------- Summary: end -------- 07:13:13 INFO - PID 761 | 07:13:15 INFO - TEST-INFO | 761: exit 0 07:13:15 INFO - TEST-OK | kraken | took 63550ms 07:13:15 INFO - SUITE-END | took 1183s 07:13:15 INFO - Completed test suite (00:19:43) 07:13:15 INFO - javascript benchmark 07:13:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6634.33604796551, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2754.2976540982054, 2781.123945957022, 2802.663680358356, 2813.4795062913363, 2824.844633545154, 5223.294855194547, 5355.223492593572, 5370.087085195516, 5397.7031263280605, 5414.40441551429, 5263.26314315996, 5329.626926115174, 5349.384820745616, 5424.972875135619, 5454.154606036061, 4443.290592743238, 4712.387389639351, 4715.717056976592, 4730.0, 4757.952420475785, 4774.73738944358, 4794.184988551937, 4814.8314808981695, 4825.927611085836, 4832.855014349575, 4584.243599806028, 4665.113628410625, 4699.342092107107, 4763.476017638057, 4792.568668819823, 4775.474697783241, 4780.7609619519235, 4780.880477988043, 4799.520047995173, 4835.734034628094, 4734.431868175807, 4736.419587904712, 4766.833160839354, 4768.57082862544, 4797.328374027639, 5080.1363768159135, 5157.8452646420665, 5171.4311425743135, 5237.397699264595, 5284.920726189111, 5741.081426971707, 5753.597248192628, 5755.0504166812425, 5782.2483077199695, 5816.069428891357, 5756.827295181151, 5773.595848290622, 5776.10470377088, 5779.537636989031, 5781.653100813965, 5188.636795424284, 5260.237265596467, 5332.653377530448, 5335.1730481775, 5335.866603334947, 5747.0, 5875.559333050039, 5881.911771323434, 5889.882202355929, 5893.911591326134, 5631.352394474606, 5694.487496125369, 5701.372848986608, 5725.8568535786935, 5752.827415177551, 5734.684592347461, 5785.652860828363, 5795.913061304083, 5795.9420405796245, 5818.185454036438, 5576.553875689935, 5660.433956604306, 5757.193992841006, 5775.27809023872, 5782.710864456844, 5590.608657393944, 5599.748011339418, 5604.187392828017, 5615.438456154352, 5619.634723742944, 4706.1528924793865, 4723.197056500403, 4798.688085274446, 4811.7834697438, 4820.276958456189, 4086.468759061303, 4136.255474014646, 4137.627613514798, 4161.334186530141, 4168.437260969791, 4926.679765815211, 4936.827211047668, 4947.233178857283, 4955.677880937727, 4989.600831933437, 5610.887782244414, 5739.799107031317, 5778.94221057784, 5783.624064435799, 5785.218995435646, 4857.757112144449, 4907.779149938261, 4981.501849814989, 4988.351514303117, 4999.950000499948, 5100.7959681613065, 5101.51535604117, 5127.9230811537855, 5128.974355128201, 5156.845294641167, 5326.121190003606, 5386.892262154814, 5387.515123638891, 5403.6217464778665, 5406.567474601944, 5559.527440167631, 5688.374278829243, 5704.2014118024335, 5793.159991801081, 5805.419458054161, 5402.027635025576, 5418.810341638024, 5420.566354691537, 5443.972780136074, 5483.259759932358, 5666.235058267246, 5701.714914254354, 5704.80033198836, 5707.571932105026, 5712.143178523254, 5631.408702086222, 5713.800016999385, 5724.599278050497, 5789.681567513659, 5810.244668193277, 5624.184493248375, 5638.295213098363, 5640.774369025357, 5669.518090962314, 5682.0, 5536.916946245729, 5573.5819813513335, 5588.972055139861, 5611.214429979887, 5613.354464236665, 5368.892622147613, 5452.645578037414, 5484.396716361277, 5499.807506737245, 5558.090627727868, 5517.255170552085, 5557.638753481011, 5596.524295434933, 5607.383187849252, 5626.662400255997, 5409.107497262908, 5475.288212532505, 5483.232347471437, 5487.067198576172, 5487.533559647474], "value": 5208.220895310527, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [728.1626129950557, 742.458005655871, 1035.0632677426927, 1048.1614708233417, 1182.3615247766206, 32092.67907320929, 32975.340493190124, 32985.0, 33171.83414082932, 33208.33583328332, 30566.0, 30961.38077238454, 31000.224994375152, 31053.534196987006, 31063.37873242534, 6224.813255602327, 6297.811065668015, 6346.365363463639, 6702.061711360413, 6872.518923675345, 6748.898766518481, 6820.863582728342, 6834.863302733942, 6838.11104556407, 6870.209925858515, 6896.275891031445, 6916.06633104532, 6953.89569156463, 6957.791266261995, 6959.130108736408, 6901.75843845468, 6904.13698287714, 6913.585184888922, 6922.7923162305215, 6929.0, 6748.662566871686, 6778.593284402902, 6795.286494918061, 6822.3859852613505, 6832.111825462658, 31118.37763244745, 31135.688643113506, 31278.37443251145, 31294.843525782453, 31408.0, 2998.8050776699447, 3016.4268788930035, 3042.1481985044225, 3063.9846800765854, 3067.9539806902912, 23961.640575391382, 23983.88008059966, 24012.759872401228, 24089.156879509308, 24118.517629647486, 2778.2498725344244, 2781.6383870096756, 2803.215099772067, 2804.3129433288773, 2815.746582807557, 142805.2859735705, 143245.28377358048, 143895.2805235967, 144190.27904860408, 144281.27859360742, 37601.24797504034, 39847.40228896569, 39910.0, 39993.400098998536, 41254.58745412568, 41767.37348939768, 41854.04773093102, 41873.0, 42031.369529457086, 43933.56066439359, 10971.890281097087, 11005.669829904955, 11007.229493935347, 11014.118870490342, 11089.500972456259, 8436.156384361515, 8492.108328625529, 8503.574821258911, 8512.616932238065, 8546.145385461405, 13044.804327935088, 13074.215547067206, 13094.14888032275, 13173.604791856067, 13266.867331326755, 5375.892482150335, 5396.244525766318, 5417.620766546304, 5471.644343117685, 5528.640638358494, 870.0516437083609, 904.2675432899241, 912.3112050401904, 931.6087243357806, 954.3939598354956, 19466.0, 20037.499062523555, 20237.08933098014, 20863.0, 21118.47203819917, 974.498133461268, 980.294188184506, 981.2248323824242, 984.9015098490237, 1005.7787286796893, 11108.222424430212, 11118.666440006813, 11225.943870280596, 11226.7193320166, 11253.831192532118, 177355.11322443307, 178379.0, 178524.21475785077, 178579.0, 179796.0, 40513.392299115534, 40576.1884762309, 40635.1872962545, 40762.79618601888, 40993.38509922354, 1231.5627952076884, 1255.5166260989402, 1260.533602567056, 1261.4449642157422, 1282.58316047285, 19309.51726206856, 19877.204911803943, 20000.69998950046, 20333.085011174237, 20693.27573534919, 28943.0, 29152.0, 36502.45246321254, 36938.076548086516, 37455.625443745215, 170484.1475792613, 170489.0, 171442.14278928525, 171470.0, 171643.0, 29391.265218368855, 29662.555061674524, 29689.554656679735, 29822.10533683993, 29950.25124371908, 34076.0, 34671.47992780161, 34719.4792078114, 35116.0, 35433.0, 26745.0, 26948.730512694623, 27462.862685686443, 27693.723062769113, 28591.85704071466, 26068.8696556516, 26663.600045998937, 27352.726472735812, 27448.039318624553, 28165.577516337682, 29359.94480386438, 29492.0, 29889.402211956072, 29921.0, 29985.850070749508, 26288.8685556571, 26907.865460672572, 27392.31519211956, 27864.721352787023, 28590.42819143564, 18358.173882175066, 19129.043547822832, 19349.61300774005, 19448.0, 19464.902675486534], "value": 14284.359123471228, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [415.56780947814275, 421.8481346715184, 423.3882040451548, 430.6705370391651, 438.86614582552306, 13955.860441395584, 14823.18472484013, 17047.232874520647, 17679.911600441996, 17688.292468301268, 18171.727424088614, 18387.26450941964, 18539.72190417145, 18548.350807721734, 18585.907070464662, 5355.169948657945, 5427.565794736412, 5446.428125046853, 5520.641158324716, 5620.4660557247, 5505.559555235572, 5600.18797274397, 5606.159076138591, 5611.438856114376, 5613.691246981414, 5213.296205012312, 5408.8377348679405, 5429.484199001088, 5437.102878025121, 5464.12573988162, 5358.276632654581, 5393.568514518829, 5410.756515956791, 5449.427810079964, 5470.480304371078, 4858.368412106439, 4923.4091908970795, 4928.926066109011, 4943.752812359404, 4945.505449455026, 22302.55394892093, 22333.553328933493, 22635.886820565956, 22648.660270095963, 22876.54246915069, 1594.4260066376096, 1626.9674606507922, 1632.126812155491, 1633.199732131259, 1634.9182540873028, 14424.134551926812, 14623.488177913829, 14802.259887005606, 14978.10131392109, 15112.924435377863, 2019.4042757386605, 2110.947226319339, 2136.391128528362, 2149.4196566927, 2155.073318473056, 89439.0, 93615.06384936132, 96039.0, 96141.0, 96669.0, 11049.668509944553, 11196.720081998015, 11289.266197697123, 11370.886291137149, 11606.651800446, 15733.44932927342, 15774.76337854933, 15784.131872746879, 15809.841901581067, 15854.128022958848, 7117.217106118323, 7180.5691658500655, 7346.816329591803, 7418.443616728767, 7458.477906546598, 6377.8838703227675, 6547.869042619216, 6565.376289252514, 6610.86778264432, 6620.966895165589, 7074.752383666547, 7278.417726581861, 7388.335049845432, 7416.443766717518, 7449.217832127657, 2112.4613223627875, 2130.20117455954, 2142.957140857174, 2154.838387120972, 2224.0992398078806, 865.952372619512, 898.797770501645, 901.4140808474544, 905.8324210021167, 931.9627214911328, 16794.244259008374, 17094.145292735564, 17529.7370539442, 17557.049663825535, 17906.5523361917, 872.2106493623281, 894.592960203119, 902.7562558109405, 907.8138981508774, 908.5139450394007, 9248.537618000486, 9469.195118414875, 9749.317547771589, 9770.75573110678, 9835.213182945346, 342263.0, 343677.0, 353496.0, 355493.0, 358614.0, 74432.0, 74646.0, 77820.61089694516, 78856.0, 79217.04663031126, 1037.3205550364523, 1059.750958524746, 1067.7597540553468, 1068.1134658233648, 1079.794838980591, 15052.3226454812, 15137.470188543348, 15311.0, 15320.693586127993, 15657.0, 35731.46402804012, 36565.268694625425, 36860.078498037765, 36870.8156459216, 37693.62306376901, 46568.301475477216, 46660.300095499275, 47158.76420617875, 47386.0, 47437.76281118573, 7829.0, 7939.166387529457, 7968.721094761656, 8122.959385203036, 8494.193051660082, 12193.268403895794, 12640.494380225056, 12737.745245095231, 12894.290814004944, 13274.80087798703, 10514.421706806199, 11055.336679799238, 11365.147613928822, 11556.0, 11706.0, 10341.63804266847, 10492.895071049192, 10514.158867290751, 10633.361998280128, 11198.664040078811, 11130.554777808797, 11418.600348987746, 11528.769424611628, 11651.242669226473, 12102.213356131822, 8584.442011269248, 8646.308295336485, 8663.133686631287, 8806.91193088061, 8818.29453643694, 10731.40977246259, 10798.892011079788, 10892.40091794959, 10906.400147991937, 11105.944470277596], "value": 8829.66794896486, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1257.46557712972, 1311.114997376771, 1315.2174456198559, 1315.9407826647794, 1328.5615746803555, 9271.860922086165, 9652.131308182263, 9678.951605241973, 9783.070608292219, 10016.599336026551, 9669.323147379686, 9854.359466634663, 9861.457619830924, 9866.950665246683, 9889.802203955916, 2119.1311562259475, 2146.0986385717956, 2148.0, 2151.8924053797327, 2152.4080877758583, 2120.9893950530304, 2177.640689286266, 2189.638709612912, 2190.452386903274, 2196.5936301784222, 2101.831853451728, 2112.0601332407086, 2131.9253826116087, 2156.870587764731, 2158.985276919845, 2128.7871212878745, 2180.3349978256624, 2182.410749097751, 2187.55155193185, 2189.1571744878256, 2044.6626306659532, 2113.936581902545, 2157.471419502216, 2161.492049368397, 2176.3906106290265, 9630.3258771886, 9687.079727425884, 9707.951460242724, 9710.514474276328, 9715.514224288829, 5124.666896651743, 5306.92039619406, 5315.813946511892, 5341.092014357569, 5342.0, 3228.2413632796274, 3266.6586625045024, 3355.580552430946, 3422.743294252941, 3436.60479044908, 1093.5899037860802, 1116.916231282657, 1122.2929554380687, 1171.4201470272185, 1190.321516735461, 13513.86486135136, 13699.794503082361, 13778.311084445737, 13820.447182112703, 13855.445782168801, 4562.771861406916, 4715.434147902273, 4955.776990035457, 4997.575206107522, 5009.599232061426, 9766.706998790047, 9789.706308810748, 9836.311458198, 9836.508174591241, 9850.113489785954, 5020.297158397827, 5038.874028149326, 5053.090443720165, 5093.490650934951, 5110.923336149961, 4502.347159661831, 4545.31820226962, 4576.450825900846, 4645.163870503275, 4664.253719404879, 3738.7569807962395, 3784.5836957934607, 3895.104126051024, 3921.627445392683, 4030.2946984277633, 1114.793763153819, 1117.8658560972735, 1123.393367581497, 1125.3641692443744, 1144.490701637763, 633.7655067625009, 653.180258775234, 677.4005005570008, 678.6878036103448, 682.0928165539821, 5088.414832294259, 5187.714675692798, 5247.396549396792, 5255.290535777697, 5346.492083252085, 545.9000114768744, 565.0366125755577, 568.5196009372074, 569.9287589051369, 576.6972339521701, 3259.1200375898848, 3264.9836750816094, 3312.519684645761, 3327.600687917417, 3369.578802649669, 11676.357800320893, 12113.75772484563, 12289.56986505468, 12435.44040518179, 12462.875371246171, 12191.72126354928, 12278.324692142018, 12439.37803109841, 12504.937475312565, 12522.311272880079, 7071.398931090812, 7230.240824713434, 7275.963620181971, 7295.598742069237, 7331.596762178131, 5424.0, 5646.689432081275, 5723.828285151452, 5749.13762935563, 5811.331696854747, 10596.152307815202, 10945.56217751313, 11049.116070714163, 11055.391953442639, 11060.0, 11104.611338603434, 11145.49845256949, 11240.213185076966, 11305.684174926857, 11424.942875285571, 7166.605836678824, 7260.237675044255, 7326.157491888501, 7328.890066649111, 7330.45021623391, 8295.211954864279, 8306.377021723274, 8368.20502052304, 8401.621927013177, 8426.368022398467, 7285.089363829521, 7420.740274090381, 7509.399248060033, 7518.436117291116, 7660.080790305199, 7134.286571342825, 7190.71237150529, 7211.71153153868, 7263.273672632695, 7326.120865495961, 6865.519413640997, 6880.105586273952, 7009.439244860501, 7100.467464940047, 7165.462590305644, 5041.823536176216, 5103.8468845934685, 5153.6907785532985, 5172.379314482287, 5183.092958732283, 5040.49595040493, 5073.315102461121, 5100.158473851773, 5196.194589838581, 5278.577713782965], "value": 4452.121514906021, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.6624040920716, 364.7738402190642, 368.99999999999983, 388.08605733497615, 390.2254025758869, 5587.636803607763, 5588.748506317215, 5610.0, 5611.130274807406, 5619.241402410678, 5481.205225242337, 5493.945060549393, 5497.5601951843855, 5497.945020549803, 5506.1190209566375, 4169.499660040799, 4198.286291330466, 4241.384999175118, 4261.659067274619, 4266.168097221043, 4238.724482908617, 4247.3223076884615, 4249.1714115747445, 4258.97870510647, 4270.121146695459, 4232.238197124517, 4233.089885674579, 4233.491980962289, 4243.384709217162, 4244.448221731186, 4175.0, 4229.577042295777, 4236.04688944988, 4238.131183107471, 4249.851255206068, 3748.306563285801, 3762.1347090169143, 3763.5107436033413, 3764.6800021998165, 3786.5266841644793, 5244.947550524484, 5267.0, 5276.894462110775, 5281.471852814726, 5283.916797056594, 4928.01439712059, 4988.825391111293, 5000.849634657096, 5023.422306434733, 5031.496850314976, 5773.509251713609, 5818.156367326714, 5822.97088514559, 5847.386024467455, 5870.0, 4154.91690166195, 4206.137741762962, 4209.65291106846, 4225.112726327475, 4227.091175397304, 5622.943770562283, 6020.367861374581, 6034.849128771772, 6073.878522429527, 6091.878162436771, 4054.0, 4095.0, 4100.282450571138, 4105.67154627629, 4115.814788334532, 4179.352200408942, 4182.749035057906, 4184.267753143188, 4185.916281674349, 4195.832166713297, 4679.853231836907, 4830.903381932341, 4831.589314908202, 4832.782524786393, 4835.927461088087, 5773.480386765212, 5790.942090579125, 5820.88358232833, 5829.88340233193, 5835.562332825055, 1419.1910610951866, 1439.165284135199, 1439.755241608929, 1440.985590144085, 1443.631873872156, 910.7495438754396, 949.5489642419795, 960.7165886063628, 970.5001924009141, 974.7611835100304, 5082.1360368737405, 5094.083065048327, 5095.286659867622, 5098.97450512745, 5129.948700513021, 6072.7570897164505, 6080.513558915276, 6083.39166083397, 6084.665343406066, 6085.421884920926, 4894.143524883131, 5069.239614057921, 5087.592992560586, 5091.87270318245, 5105.821296254688, 3169.397814415254, 3197.8720851165695, 3202.7580693514633, 3203.3913556424673, 3208.98395508021, 5450.945490545123, 5693.516051135617, 5693.772249110072, 5695.0, 5721.22763426932, 6056.152138700585, 6158.445739883342, 6173.715725181622, 6208.0, 6217.751289948352, 5685.573581981368, 5700.118960742945, 5704.602372418784, 5715.914261286167, 5723.799667011801, 5999.88000239984, 6033.879322413615, 6085.421884920926, 6095.9390406097145, 6121.357257488078, 5916.698326368192, 5965.642061476326, 5968.76124954997, 5973.522118230618, 5987.0, 5660.150977353265, 5679.176519404746, 5682.925732107668, 5692.914606280826, 5703.828885133453, 3984.744805386294, 4064.5122585289955, 4108.301588729863, 4113.341865301538, 4114.958850411457, 6041.969790151021, 6053.939460605337, 6072.787452439144, 6077.726502307319, 6087.847803804941, 5706.80026199081, 5848.502877255481, 5848.590598658223, 5861.9706901465215, 5871.588988770745, 5783.450572195635, 5812.738426770721, 5839.328477225004, 5845.970770146122, 5859.531237501075, 5730.255066841284, 5734.397888221677, 5738.885222295614, 5744.195812586157, 5793.971030144822, 5715.542756579547, 5761.251037365116, 5857.26784151981, 5858.736356864037, 5891.675957822361, 5672.943270567242, 5673.120666296731, 5677.858053548529, 5712.400197979152, 5719.342275638355], "value": 4370.91555332816, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [649.2922714241482, 652.494316904399, 721.4444877444367, 730.6821532633305, 752.3229093815565, 13475.865241347583, 13936.860631393696, 13962.790558141636, 15772.290246938886, 17204.39784607539, 16057.678846423094, 16302.184890755474, 16346.10096444695, 16401.0, 16922.661546769086, 893.5398269890995, 905.7871400220943, 909.549772862434, 910.1444642036498, 911.0980129671643, 884.5400391796262, 898.9595468203914, 900.0369604523163, 904.760238536785, 905.6603773584906, 948.5257371314343, 957.3633533700081, 958.1616085924816, 959.0, 960.255801753643, 938.6761567259318, 943.6461327002374, 947.5499137909507, 948.127722495299, 952.3190918493241, 696.7839969609387, 697.891826766852, 699.7655785311927, 700.5796522086758, 704.4082970304969, 14765.483208087773, 14832.184229867353, 14836.851631483654, 14849.257537123101, 15392.538223853302, 16176.191190440431, 16180.595485112848, 16479.91760041204, 16536.66926661472, 16701.66596668072, 12340.197887137307, 12490.625281241486, 12656.430460629294, 12735.044871634573, 12871.742565148737, 2761.4891245119716, 2773.251222170023, 2788.9023884164158, 2792.762615177692, 2796.314902848815, 72714.0, 74777.5044499107, 74935.25064749338, 75730.62134689401, 76625.61687191584, 12643.367831608566, 12737.299448530235, 12753.744925101446, 12756.0, 12766.80849787254, 22678.319650410514, 22918.197863075045, 23183.76816231816, 23365.0, 23385.766142338358, 6073.726682299307, 6095.451409373178, 6329.905051424233, 6339.080833279241, 6345.0482427636225, 3030.9696903030685, 3049.4510988021925, 3066.601341825593, 3088.1970687620933, 3102.8913988010313, 3324.9335013299597, 3426.811525366129, 3446.4485682290715, 3448.4310088835564, 3452.6202117767025, 638.52748965765, 645.7255666341786, 649.1885143570537, 650.1710319342876, 652.2336254900473, 571.7970120607208, 580.6254965547283, 582.8226981497352, 588.2881713127078, 600.9579329446897, 8495.856533082675, 8640.222379985831, 8652.586446464747, 8924.196822286025, 9146.95426522863, 522.4749127127288, 535.5046581911716, 537.1539824775994, 549.4395716369281, 551.1209620655048, 4017.879463616096, 4032.8185231664647, 4068.816903239361, 4081.428599996003, 4086.1827634473225, 60753.39246607566, 60931.6953415239, 61306.693466533274, 62740.37259627345, 63811.680941595, 48973.265401019016, 50241.748791255806, 50777.238341424905, 51017.0, 57302.14046789301, 46177.30734038992, 46485.5351446488, 47132.0, 47134.0, 47872.760636197294, 9203.217726493323, 9356.719298421058, 9461.0, 9645.035496450579, 9872.851907221253, 24314.63528047116, 25327.620085699098, 25366.746332536437, 25387.61918571186, 26039.0, 30728.078157655305, 41975.58024419717, 43632.34551481667, 43650.12699746051, 44933.10133797371, 13011.414486347947, 13063.608091757262, 13181.0, 13191.472341106632, 13281.535146269835, 13651.11267767592, 13661.316934153452, 13738.931305343409, 13825.377857996615, 13863.0, 12342.259464432163, 12519.874801251872, 12656.0, 12781.105322627327, 12788.616341509769, 13299.20204787716, 13603.863961360259, 13694.726105477635, 13802.585922422344, 13979.790303145257, 12276.631701048982, 12414.813777793159, 12544.937275313565, 12555.0, 12643.936780316408, 9688.806223875625, 9747.902520974983, 9986.300958933096, 10067.748306292402, 10104.545295461576, 9801.36291141102, 10020.198384129106, 10208.081272685495, 10325.586976520855, 10340.638077667245], "value": 6669.889302802417, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1535.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 112.0, 113.0, 113.0, 111.0, 113.0, 112.0, 111.0, 111.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 130.0, 125.0, 164.0, 124.0, 122.0, 124.0, 124.0, 144.0, 123.0], "value": 133.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 164.0, 167.0, 170.0, 180.0, 165.0, 166.0, 164.0, 164.0], "value": 166.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 111.0, 74.0, 74.0, 75.0, 74.0, 93.0, 79.0], "value": 80.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 108.0, 84.0, 82.0, 83.0, 96.0, 83.0, 83.0, 111.0], "value": 89.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 113.0, 114.0, 114.0, 114.0, 113.0, 118.0, 115.0, 114.0], "value": 114.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 151.0, 150.0, 151.0, 150.0, 150.0, 149.0, 150.0, 152.0, 150.0], "value": 150.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 94.0, 95.0, 94.0, 95.0, 94.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 53.0, 54.0, 54.0, 55.0, 56.0, 55.0, 55.0, 55.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 56.0, 55.0, 55.0, 55.0, 55.0, 56.0, 56.0, 56.0], "value": 55.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 82.0, 82.0, 81.0, 92.0, 84.0, 83.0, 81.0, 84.0, 83.0], "value": 84.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 135.0, 146.0, 129.0, 129.0, 137.0, 141.0, 130.0, 231.0, 129.0], "value": 144.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 186.0, 191.0, 186.0, 186.0, 178.0, 183.0, 193.0, 186.0, 186.0], "value": 185.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 73.0, 70.0, 71.0, 72.0, 70.0, 69.0, 70.0, 69.0, 70.0], "value": 70.4, "unit": "score"}]}]} 07:13:15 INFO - Return code: 0 07:13:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:13:15 INFO - # TBPL SUCCESS # 07:13:15 INFO - Running post-action listener: _resource_record_post_action 07:13:15 INFO - [mozharness: 2017-05-05 14:13:15.773710Z] Finished run-tests step (success) 07:13:15 INFO - Running post-run listener: _resource_record_post_run 07:13:15 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 24576; Write bytes: 356839424; Read time: 396; Write time: 210696 07:13:15 INFO - TinderboxPrint: CPU usage
13.3% 07:13:15 INFO - TinderboxPrint: I/O read bytes / time
24,576 / 396 07:13:15 INFO - TinderboxPrint: I/O write bytes / time
356,839,424 / 210,696 07:13:15 INFO - TinderboxPrint: CPU idle
8,296.4 (86.7%) 07:13:15 INFO - TinderboxPrint: CPU user
1,216.8 (12.7%) 07:13:15 INFO - TinderboxPrint: Swap in / out
0 / 0 07:13:15 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 8192; Write bytes: 97787904; Read time: 220; Write time: 70224 07:13:15 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 16384; Write bytes: 259051520; Read time: 176; Write time: 140472 07:13:16 INFO - Running post-run listener: _upload_blobber_files 07:13:16 INFO - Blob upload gear active. 07:13:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:13:16 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:13:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:13:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:13:16 INFO - (blobuploader) - INFO - Open directory for files ... 07:13:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:13:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:13:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:13:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:13:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:13:17 INFO - (blobuploader) - INFO - Done attempting. 07:13:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:13:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:13:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:13:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:13:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:13:18 INFO - (blobuploader) - INFO - Done attempting. 07:13:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:13:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:13:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:13:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:13:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:13:22 INFO - (blobuploader) - INFO - Done attempting. 07:13:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:13:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:13:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:13:23 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:13:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:13:23 INFO - (blobuploader) - INFO - Done attempting. 07:13:23 INFO - (blobuploader) - INFO - Iteration through files over. 07:13:23 INFO - Return code: 0 07:13:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:13:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:13:23 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/18d05cb976263db12b462d2886be68b3e81e24fedc8f2aa9607c307749ec73f4b8a959e2b78e354a1a4184efeff5cc7f6711e0bd5ae5298228583aac2b3f88d0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b73779b474784b6f6aa7ce86b5139f98368ff7bb98fbd2e01ee993407452f932629f4a653982ba46a1ff4e15a7402903468bb8f96497bc2a61aa029241a377ce", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/92a0f39c46d6e58ee9d67dc9efe493f300688919b802f43a0f68797185ea7f108fd0128bc77108ef1a8f33cb6516d8c8cb02c32d40d73dcc749b3769122c68a4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/94f7639863bea97ca7ceee62f7013b03ab26562cc2d8cc1a8a06de4becdc3c6235dd92cec1225afcae80d82e5f7c32b6216a8aeb7698356877e830b689d964ba"} 07:13:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:13:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:13:23 INFO - Contents: 07:13:23 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/18d05cb976263db12b462d2886be68b3e81e24fedc8f2aa9607c307749ec73f4b8a959e2b78e354a1a4184efeff5cc7f6711e0bd5ae5298228583aac2b3f88d0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b73779b474784b6f6aa7ce86b5139f98368ff7bb98fbd2e01ee993407452f932629f4a653982ba46a1ff4e15a7402903468bb8f96497bc2a61aa029241a377ce", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/92a0f39c46d6e58ee9d67dc9efe493f300688919b802f43a0f68797185ea7f108fd0128bc77108ef1a8f33cb6516d8c8cb02c32d40d73dcc749b3769122c68a4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/94f7639863bea97ca7ceee62f7013b03ab26562cc2d8cc1a8a06de4becdc3c6235dd92cec1225afcae80d82e5f7c32b6216a8aeb7698356877e830b689d964ba"} 07:13:23 INFO - Running post-run listener: copy_logs_to_upload_dir 07:13:23 INFO - Copying logs to upload dir... 07:13:23 INFO - mkdir: /builds/slave/test/build/upload/logs 07:13:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.543068 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-05-05 07:13:22.652829) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-05 07:13:22.657880) ========= 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=41bf3e9aed84707956354da8000001c5-1493992225.467577-93714130 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/Firefox/sha512/18d05cb976263db12b462d2886be68b3e81e24fedc8f2aa9607c307749ec73f4b8a959e2b78e354a1a4184efeff5cc7f6711e0bd5ae5298228583aac2b3f88d0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b73779b474784b6f6aa7ce86b5139f98368ff7bb98fbd2e01ee993407452f932629f4a653982ba46a1ff4e15a7402903468bb8f96497bc2a61aa029241a377ce", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/92a0f39c46d6e58ee9d67dc9efe493f300688919b802f43a0f68797185ea7f108fd0128bc77108ef1a8f33cb6516d8c8cb02c32d40d73dcc749b3769122c68a4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/94f7639863bea97ca7ceee62f7013b03ab26562cc2d8cc1a8a06de4becdc3c6235dd92cec1225afcae80d82e5f7c32b6216a8aeb7698356877e830b689d964ba"} build_url:https://queue.taskcluster.net/v1/task/EMsWWJAtR8KN2KkWpNBSIA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011421 build_url: 'https://queue.taskcluster.net/v1/task/EMsWWJAtR8KN2KkWpNBSIA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/18d05cb976263db12b462d2886be68b3e81e24fedc8f2aa9607c307749ec73f4b8a959e2b78e354a1a4184efeff5cc7f6711e0bd5ae5298228583aac2b3f88d0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b73779b474784b6f6aa7ce86b5139f98368ff7bb98fbd2e01ee993407452f932629f4a653982ba46a1ff4e15a7402903468bb8f96497bc2a61aa029241a377ce", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/92a0f39c46d6e58ee9d67dc9efe493f300688919b802f43a0f68797185ea7f108fd0128bc77108ef1a8f33cb6516d8c8cb02c32d40d73dcc749b3769122c68a4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/94f7639863bea97ca7ceee62f7013b03ab26562cc2d8cc1a8a06de4becdc3c6235dd92cec1225afcae80d82e5f7c32b6216a8aeb7698356877e830b689d964ba"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-05 07:13:22.687084) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 07:13:22.687481) ========= 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=41bf3e9aed84707956354da8000001c5-1493992225.467577-93714130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004549 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 07:13:22.770509) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-05 07:13:22.770928) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-05 07:13:22.771317) ========= ========= Total master_lag: 0.94 =========