builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-049 starttime: 1482274222.82 results: success (0) buildid: 20161220131053 builduid: 1827dd043e834917a059b4c7993c5f77 revision: 1e46434c7b43128830f1cd34b4372c06366912ee ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-20 14:50:22.823076) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-20 14:50:22.823749) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-20 14:50:22.824209) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-20 14:50:22.840198) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 14:50:22.840724) ========= 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=db7e7c15f3ca076d53731445000001ba-1482274222.659172-224554726 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-20 14:50:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 70.1M=0s 2016-12-20 14:50:23 (70.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.137526 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 14:50:22.997975) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 14:50:22.998515) ========= 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=db7e7c15f3ca076d53731445000001ba-1482274222.659172-224554726 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015477 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 14:50:23.048558) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-20 14:50:23.048911) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1e46434c7b43128830f1cd34b4372c06366912ee --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1e46434c7b43128830f1cd34b4372c06366912ee --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=db7e7c15f3ca076d53731445000001ba-1482274222.659172-224554726 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-20 14:50:23,625 truncating revision to first 12 chars 2016-12-20 14:50:23,625 Setting DEBUG logging. 2016-12-20 14:50:23,625 attempt 1/10 2016-12-20 14:50:23,625 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1e46434c7b43?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-20 14:50:24,675 unpacking tar archive at: mozilla-aurora-1e46434c7b43/testing/mozharness/ program finished with exit code 0 elapsedTime=1.449838 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-20 14:50:24.513637) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-20 14:50:24.514138) ========= script_repo_revision: 1e46434c7b43128830f1cd34b4372c06366912ee ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-20 14:50:24.514717) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-20 14:50:24.515153) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-20 14:50:24.525854) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-12-20 14:50:24.526178) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=db7e7c15f3ca076d53731445000001ba-1482274222.659172-224554726 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:50:25 INFO - MultiFileLogger online at 20161220 14:50:25 in /builds/slave/test 14:50:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 14:50:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:50:25 INFO - {'append_to_log': False, 14:50:25 INFO - 'base_work_dir': '/builds/slave/test', 14:50:25 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 14:50:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:50:25 INFO - 'branch': 'Mozilla-Aurora', 14:50:25 INFO - 'buildbot_json_path': 'buildprops.json', 14:50:25 INFO - 'config_files': ('talos/linux_config.py',), 14:50:25 INFO - 'default_actions': ('clobber', 14:50:25 INFO - 'read-buildbot-config', 14:50:25 INFO - 'download-and-extract', 14:50:25 INFO - 'populate-webroot', 14:50:25 INFO - 'create-virtualenv', 14:50:25 INFO - 'install', 14:50:25 INFO - 'run-tests'), 14:50:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:50:25 INFO - 'download_minidump_stackwalk': True, 14:50:25 INFO - 'download_symbols': 'ondemand', 14:50:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:50:25 INFO - 'tooltool.py': '/tools/tooltool.py', 14:50:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:50:25 INFO - '/tools/misc-python/virtualenv.py')}, 14:50:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:50:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:50:25 INFO - 'installer_path': 'installer.exe', 14:50:25 INFO - 'log_level': 'info', 14:50:25 INFO - 'log_name': 'talos', 14:50:25 INFO - 'log_to_console': True, 14:50:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:50:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:50:25 INFO - 'opt_config_files': (), 14:50:25 INFO - 'pip_index': False, 14:50:25 INFO - 'sps_profile': False, 14:50:25 INFO - 'sps_profile_interval': 0, 14:50:25 INFO - 'suite': 'dromaeojs', 14:50:25 INFO - 'system_bits': '32', 14:50:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:50:25 INFO - 'title': 'talos-linux64-ix-049', 14:50:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:50:25 INFO - 'use_talos_json': True, 14:50:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:50:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:50:25 INFO - 'work_dir': 'build'} 14:50:25 INFO - [mozharness: 2016-12-20 22:50:25.187302Z] Running clobber step. 14:50:25 INFO - Running pre-action listener: _resource_record_pre_action 14:50:25 INFO - Running main action method: clobber 14:50:25 INFO - rmtree: /builds/slave/test/build 14:50:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:50:25 INFO - Running post-action listener: _resource_record_post_action 14:50:25 INFO - [mozharness: 2016-12-20 22:50:25.715375Z] Finished clobber step (success) 14:50:25 INFO - [mozharness: 2016-12-20 22:50:25.715474Z] Running read-buildbot-config step. 14:50:25 INFO - Running pre-action listener: _resource_record_pre_action 14:50:25 INFO - Running main action method: read_buildbot_config 14:50:25 INFO - Using buildbot properties: 14:50:25 INFO - { 14:50:25 INFO - "project": "", 14:50:25 INFO - "product": "firefox", 14:50:25 INFO - "script_repo_revision": "production", 14:50:25 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 14:50:25 INFO - "repository": "", 14:50:25 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 14:50:25 INFO - "buildid": "20161220131053", 14:50:25 INFO - "pgo_build": "True", 14:50:25 INFO - "basedir": "/builds/slave/test", 14:50:25 INFO - "buildnumber": 967, 14:50:25 INFO - "slavename": "talos-linux64-ix-049", 14:50:25 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:50:25 INFO - "platform": "ubuntu64_hw", 14:50:25 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 14:50:25 INFO - "branch": "mozilla-aurora", 14:50:25 INFO - "repo_path": "releases/mozilla-aurora", 14:50:25 INFO - "revision": "1e46434c7b43128830f1cd34b4372c06366912ee", 14:50:25 INFO - "stage_platform": "linux64-pgo", 14:50:25 INFO - "builduid": "1827dd043e834917a059b4c7993c5f77", 14:50:25 INFO - "slavebuilddir": "test" 14:50:25 INFO - } 14:50:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/e7Row3e3Q8avAgCiBVqB2Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 14:50:25 INFO - Running post-action listener: _resource_record_post_action 14:50:25 INFO - [mozharness: 2016-12-20 22:50:25.717885Z] Finished read-buildbot-config step (success) 14:50:25 INFO - [mozharness: 2016-12-20 22:50:25.717973Z] Running download-and-extract step. 14:50:25 INFO - Running pre-action listener: _resource_record_pre_action 14:50:25 INFO - Running main action method: download_and_extract 14:50:25 INFO - mkdir: /builds/slave/test/build/tests 14:50:25 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')]} 14:50:25 INFO - trying https://queue.taskcluster.net/v1/task/e7Row3e3Q8avAgCiBVqB2Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 14:50:25 INFO - Downloading https://queue.taskcluster.net/v1/task/e7Row3e3Q8avAgCiBVqB2Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 14:50:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e7Row3e3Q8avAgCiBVqB2Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:50:26 INFO - Downloaded 1361 bytes. 14:50:26 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 14:50:26 INFO - Using the following test package requirements: 14:50:26 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 14:50:26 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 14:50:26 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 14:50:26 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 14:50:26 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 14:50:26 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 14:50:26 INFO - u'jsshell-linux-x86_64.zip'], 14:50:26 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 14:50:26 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 14:50:26 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 14:50:26 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 14:50:26 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 14:50:26 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 14:50:26 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 14:50:26 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 14:50:26 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 14:50:26 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 14:50:26 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 14:50:26 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:50:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/e7Row3e3Q8avAgCiBVqB2Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 14:50:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e7Row3e3Q8avAgCiBVqB2Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:50:26 INFO - Fetch https://queue.taskcluster.net/v1/task/e7Row3e3Q8avAgCiBVqB2Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 14:50:26 INFO - Http code: 200 14:50:26 INFO - via: 1.1 ccaa055c9a26ce13da709353563e04a5.cloudfront.net (CloudFront) 14:50:26 INFO - x-amz-cf-id: 5f6WAkXN-YoIv-VEBDRsSRLgvH1WK172NqDlkOvxH-fwYxQbnRvamg== 14:50:26 INFO - x-amz-version-id: UdvpH1iKUVglHE94c885Aah9mFTAdFRc 14:50:27 INFO - Expected file size: 21940786 14:50:27 INFO - Obtained file size: 21940786 14:50:31 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:50:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/e7Row3e3Q8avAgCiBVqB2Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 14:50:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e7Row3e3Q8avAgCiBVqB2Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:50:31 INFO - Fetch https://queue.taskcluster.net/v1/task/e7Row3e3Q8avAgCiBVqB2Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 14:50:31 INFO - Http code: 200 14:50:31 INFO - via: 1.1 76bce8bb4fbd102fc0b3aa2e41094b79.cloudfront.net (CloudFront) 14:50:31 INFO - x-amz-cf-id: YUKEzlF6hUqOFSeeCGQilQK7xQH41cZOp-AWHhlDA3mOX2_pOqC7OA== 14:50:31 INFO - x-amz-version-id: UdvpH1iKUVglHE94c885Aah9mFTAdFRc 14:50:33 INFO - Expected file size: 21940786 14:50:33 INFO - Obtained file size: 21940786 14:50:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/e7Row3e3Q8avAgCiBVqB2Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 14:50:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e7Row3e3Q8avAgCiBVqB2Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:50:38 INFO - Fetch https://queue.taskcluster.net/v1/task/e7Row3e3Q8avAgCiBVqB2Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 14:50:38 INFO - Http code: 200 14:50:38 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 14:50:38 INFO - x-amz-cf-id: MG-nC6z_ydOxkp7PJpGztqfD8jQyYwqQKg7HobBP2EiBvqDa0i83KQ== 14:50:38 INFO - x-amz-version-id: ss5GfEOhwZUDPEeGWSXSqoROyqJVtR09 14:50:38 INFO - Expected file size: 14409038 14:50:38 INFO - Obtained file size: 14409038 14:50:39 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')]} 14:50:39 INFO - trying https://queue.taskcluster.net/v1/task/e7Row3e3Q8avAgCiBVqB2Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 14:50:39 INFO - Downloading https://queue.taskcluster.net/v1/task/e7Row3e3Q8avAgCiBVqB2Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 14:50:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e7Row3e3Q8avAgCiBVqB2Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:50:40 INFO - Downloaded 63951822 bytes. 14:50:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/e7Row3e3Q8avAgCiBVqB2Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 14:50:40 INFO - mkdir: /builds/slave/test/properties 14:50:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:50:40 INFO - Writing to file /builds/slave/test/properties/build_url 14:50:40 INFO - Contents: 14:50:40 INFO - build_url:https://queue.taskcluster.net/v1/task/e7Row3e3Q8avAgCiBVqB2Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 14:50:41 INFO - Running post-action listener: _resource_record_post_action 14:50:41 INFO - Running post-action listener: set_extra_try_arguments 14:50:41 INFO - [mozharness: 2016-12-20 22:50:41.277449Z] Finished download-and-extract step (success) 14:50:41 INFO - [mozharness: 2016-12-20 22:50:41.277674Z] Running populate-webroot step. 14:50:41 INFO - Running pre-action listener: _resource_record_pre_action 14:50:41 INFO - Running main action method: populate_webroot 14:50:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:50:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:50:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:50:41 INFO - '--tppagecycles', 14:50:41 INFO - '7'], 14:50:41 INFO - 'tests': ['tsvgm']}}, 14:50:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:50:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:50:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:50:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:50:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:50:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:50:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:50:41 INFO - 'talos_options': ['--disable-e10s'], 14:50:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:50:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:50:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:50:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:50:41 INFO - 'talos_options': ['--disable-e10s'], 14:50:41 INFO - 'tests': ['damp', 'tps']}, 14:50:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:50:41 INFO - 'tests': ['damp', 'tps']}, 14:50:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:50:41 INFO - 'tests': ['dromaeo_dom']}, 14:50:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:50:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:50:41 INFO - 'tests': ['basic_compositor_video']}, 14:50:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:50:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:50:41 INFO - 'tests': ['a11yr', 14:50:41 INFO - 'ts_paint', 14:50:41 INFO - 'tpaint', 14:50:41 INFO - 'sessionrestore', 14:50:41 INFO - 'sessionrestore_no_auto_restore', 14:50:41 INFO - 'tabpaint']}, 14:50:41 INFO - 'other-e10s': {'tests': ['a11yr', 14:50:41 INFO - 'ts_paint', 14:50:41 INFO - 'tpaint', 14:50:41 INFO - 'sessionrestore', 14:50:41 INFO - 'sessionrestore_no_auto_restore', 14:50:41 INFO - 'tabpaint']}, 14:50:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:50:41 INFO - 'ts_paint', 14:50:41 INFO - 'tpaint', 14:50:41 INFO - 'sessionrestore', 14:50:41 INFO - 'sessionrestore_no_auto_restore', 14:50:41 INFO - 'tabpaint']}, 14:50:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:50:41 INFO - 'ts_paint', 14:50:41 INFO - 'tpaint', 14:50:41 INFO - 'sessionrestore', 14:50:41 INFO - 'sessionrestore_no_auto_restore', 14:50:41 INFO - 'tabpaint']}, 14:50:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:50:41 INFO - 'tests': ['a11yr', 14:50:41 INFO - 'ts_paint', 14:50:41 INFO - 'tpaint', 14:50:41 INFO - 'sessionrestore', 14:50:41 INFO - 'sessionrestore_no_auto_restore', 14:50:41 INFO - 'tabpaint']}, 14:50:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:50:41 INFO - 'tests': ['a11yr', 14:50:41 INFO - 'ts_paint', 14:50:41 INFO - 'tpaint', 14:50:41 INFO - 'sessionrestore', 14:50:41 INFO - 'sessionrestore_no_auto_restore', 14:50:41 INFO - 'tabpaint']}, 14:50:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:50:41 INFO - 'tests': ['tsvgx', 14:50:41 INFO - 'tsvgr_opacity', 14:50:41 INFO - 'tart', 14:50:41 INFO - 'tscrollx', 14:50:41 INFO - 'cart']}, 14:50:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:50:41 INFO - 'tsvgr_opacity', 14:50:41 INFO - 'tart', 14:50:41 INFO - 'tscrollx', 14:50:41 INFO - 'cart']}, 14:50:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:50:41 INFO - 'talos_options': ['--disable-e10s'], 14:50:41 INFO - 'tests': ['tp5o']}, 14:50:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:50:41 INFO - 'tests': ['tp5o']}, 14:50:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:50:41 INFO - 'talos_options': ['--disable-e10s', 14:50:41 INFO - '--xperf_path', 14:50:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:50:41 INFO - 'tests': ['tp5n']}, 14:50:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:50:41 INFO - 'talos_options': ['--xperf_path', 14:50:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:50:41 INFO - 'tests': ['tp5n']}}, 14:50:41 INFO - 'talos.zip': {'path': '', 14:50:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:50:41 INFO - Running post-action listener: _resource_record_post_action 14:50:41 INFO - [mozharness: 2016-12-20 22:50:41.296785Z] Finished populate-webroot step (success) 14:50:41 INFO - [mozharness: 2016-12-20 22:50:41.296872Z] Running create-virtualenv step. 14:50:41 INFO - Running pre-action listener: _resource_record_pre_action 14:50:41 INFO - Running main action method: create_virtualenv 14:50:41 INFO - Creating virtualenv /builds/slave/test/build/venv 14:50:41 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 14:50:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:50:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:50:41 INFO - Using real prefix '/usr' 14:50:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:50:41 INFO - Installing distribute.............................................................................................................................................................................................done. 14:50:43 INFO - Installing pip.................done. 14:50:43 INFO - Return code: 0 14:50:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:50:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:50:44 INFO - Reading from file tmpfile_stdout 14:50:44 INFO - Output received: 14:50:44 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) 14:50:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:50:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:50:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:50:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:50:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:50:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:50:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:50:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6e6885f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad5f60>, '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 0x1ad6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad71d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1482274222.659172-224554726', '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 14:50:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:50:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:50:44 INFO - Using env: {'DISPLAY': ':0', 14:50:44 INFO - 'HOME': '/home/cltbld', 14:50:44 INFO - 'LANG': 'en_US.UTF-8', 14:50:44 INFO - 'LANGUAGE': 'en_US:en', 14:50:44 INFO - 'LOGNAME': 'cltbld', 14:50:44 INFO - 'MAIL': '/var/mail/cltbld', 14:50:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:50:44 INFO - 'MOZ_NO_REMOTE': '1', 14:50:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:50:44 INFO - 'NO_EM_RESTART': '1', 14:50:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:50:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:50:44 INFO - 'PWD': '/builds/slave/test', 14:50:44 INFO - 'SHELL': '/bin/bash', 14:50:44 INFO - 'SHLVL': '1', 14:50:44 INFO - 'TERM': 'linux', 14:50:44 INFO - 'TMOUT': '86400', 14:50:44 INFO - 'USER': 'cltbld', 14:50:44 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1482274222.659172-224554726', 14:50:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:50:44 INFO - '_': '/tools/buildbot/bin/python'} 14:50:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:50:44 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 14:50:44 INFO - Cleaning up... 14:50:44 INFO - Return code: 0 14:50:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:50:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:50:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:50:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:50:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:50:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:50:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:50:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff6e6885f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad5f60>, '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 0x1ad6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad71d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1482274222.659172-224554726', '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 14:50:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:50:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:50:44 INFO - Using env: {'DISPLAY': ':0', 14:50:44 INFO - 'HOME': '/home/cltbld', 14:50:44 INFO - 'LANG': 'en_US.UTF-8', 14:50:44 INFO - 'LANGUAGE': 'en_US:en', 14:50:44 INFO - 'LOGNAME': 'cltbld', 14:50:44 INFO - 'MAIL': '/var/mail/cltbld', 14:50:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:50:44 INFO - 'MOZ_NO_REMOTE': '1', 14:50:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:50:44 INFO - 'NO_EM_RESTART': '1', 14:50:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:50:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:50:44 INFO - 'PWD': '/builds/slave/test', 14:50:44 INFO - 'SHELL': '/bin/bash', 14:50:44 INFO - 'SHLVL': '1', 14:50:44 INFO - 'TERM': 'linux', 14:50:44 INFO - 'TMOUT': '86400', 14:50:44 INFO - 'USER': 'cltbld', 14:50:44 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1482274222.659172-224554726', 14:50:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:50:44 INFO - '_': '/tools/buildbot/bin/python'} 14:50:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:50:44 INFO - Downloading/unpacking psutil>=3.1.1 14:50:44 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 14:50:44 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 14:50:44 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 14:50:44 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 14:50:44 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 14:50:44 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 14:50:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:50:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:50:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:50:46 INFO - Installing collected packages: psutil 14:50:46 INFO - Running setup.py install for psutil 14:50:46 INFO - building 'psutil._psutil_linux' extension 14:50:46 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 14:50:46 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 14:50:46 INFO - building 'psutil._psutil_posix' extension 14:50:46 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 14:50:47 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 14:50:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:50:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:50:47 INFO - Successfully installed psutil 14:50:47 INFO - Cleaning up... 14:50:47 INFO - Return code: 0 14:50:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:50:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:50:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:50:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:50:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:50:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:50:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:50:47 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 0x7ff6e6885f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad5f60>, '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 0x1ad6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad71d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1482274222.659172-224554726', '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 14:50:47 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 14:50:47 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 14:50:47 INFO - Using env: {'DISPLAY': ':0', 14:50:47 INFO - 'HOME': '/home/cltbld', 14:50:47 INFO - 'LANG': 'en_US.UTF-8', 14:50:47 INFO - 'LANGUAGE': 'en_US:en', 14:50:47 INFO - 'LOGNAME': 'cltbld', 14:50:47 INFO - 'MAIL': '/var/mail/cltbld', 14:50:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:50:47 INFO - 'MOZ_NO_REMOTE': '1', 14:50:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:50:47 INFO - 'NO_EM_RESTART': '1', 14:50:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:50:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:50:47 INFO - 'PWD': '/builds/slave/test', 14:50:47 INFO - 'SHELL': '/bin/bash', 14:50:47 INFO - 'SHLVL': '1', 14:50:47 INFO - 'TERM': 'linux', 14:50:47 INFO - 'TMOUT': '86400', 14:50:47 INFO - 'USER': 'cltbld', 14:50:47 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1482274222.659172-224554726', 14:50:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:50:47 INFO - '_': '/tools/buildbot/bin/python'} 14:50:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:50:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:50:47 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 14:50:47 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 14:50:47 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 14:50:47 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 14:50:47 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 14:50:47 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 14:50:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:50:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:50:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:50:49 INFO - Installing collected packages: mozsystemmonitor 14:50:49 INFO - Running setup.py install for mozsystemmonitor 14:50:49 INFO - Successfully installed mozsystemmonitor 14:50:49 INFO - Cleaning up... 14:50:49 INFO - Return code: 0 14:50:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:50:49 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')]} 14:50:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:50:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:50:49 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')]} 14:50:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:50:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:50:49 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 0x7ff6e6885f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad5f60>, '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 0x1ad6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad71d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1482274222.659172-224554726', '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 14:50:49 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 14:50:49 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 14:50:49 INFO - Using env: {'DISPLAY': ':0', 14:50:49 INFO - 'HOME': '/home/cltbld', 14:50:49 INFO - 'LANG': 'en_US.UTF-8', 14:50:49 INFO - 'LANGUAGE': 'en_US:en', 14:50:49 INFO - 'LOGNAME': 'cltbld', 14:50:49 INFO - 'MAIL': '/var/mail/cltbld', 14:50:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:50:49 INFO - 'MOZ_NO_REMOTE': '1', 14:50:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:50:49 INFO - 'NO_EM_RESTART': '1', 14:50:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:50:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:50:49 INFO - 'PWD': '/builds/slave/test', 14:50:49 INFO - 'SHELL': '/bin/bash', 14:50:49 INFO - 'SHLVL': '1', 14:50:49 INFO - 'TERM': 'linux', 14:50:49 INFO - 'TMOUT': '86400', 14:50:49 INFO - 'USER': 'cltbld', 14:50:49 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1482274222.659172-224554726', 14:50:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:50:49 INFO - '_': '/tools/buildbot/bin/python'} 14:50:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:50:49 INFO - Downloading/unpacking jsonschema==2.5.1 14:50:49 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 14:50:49 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 14:50:49 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 14:50:49 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 14:50:49 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 14:50:49 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 14:50:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:50:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:50:51 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 14:50:51 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 14:50:51 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 14:50:51 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 14:50:51 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 14:50:51 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 14:50:52 INFO - Downloading functools32-3.2.3-2.tar.gz 14:50:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:50:52 INFO - warning: no files found matching '*.txt' 14:50:52 INFO - no previously-included directories found matching 'build' 14:50:52 INFO - no previously-included directories found matching 'dist' 14:50:52 INFO - no previously-included directories found matching '.git*' 14:50:52 INFO - Installing collected packages: jsonschema, functools32 14:50:52 INFO - Running setup.py install for functools32 14:50:52 INFO - warning: no files found matching '*.txt' 14:50:52 INFO - no previously-included directories found matching 'build' 14:50:52 INFO - no previously-included directories found matching 'dist' 14:50:52 INFO - no previously-included directories found matching '.git*' 14:50:52 INFO - Successfully installed jsonschema functools32 14:50:52 INFO - Cleaning up... 14:50:52 INFO - Return code: 0 14:50:52 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:50:52 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')]} 14:50:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:50:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:50:52 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')]} 14:50:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:50:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:50:52 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 0x7ff6e6885f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad5f60>, '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 0x1ad6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad71d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1482274222.659172-224554726', '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 14:50:52 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 14:50:52 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 14:50:52 INFO - Using env: {'DISPLAY': ':0', 14:50:52 INFO - 'HOME': '/home/cltbld', 14:50:52 INFO - 'LANG': 'en_US.UTF-8', 14:50:52 INFO - 'LANGUAGE': 'en_US:en', 14:50:52 INFO - 'LOGNAME': 'cltbld', 14:50:52 INFO - 'MAIL': '/var/mail/cltbld', 14:50:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:50:52 INFO - 'MOZ_NO_REMOTE': '1', 14:50:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:50:52 INFO - 'NO_EM_RESTART': '1', 14:50:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:50:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:50:52 INFO - 'PWD': '/builds/slave/test', 14:50:52 INFO - 'SHELL': '/bin/bash', 14:50:52 INFO - 'SHLVL': '1', 14:50:52 INFO - 'TERM': 'linux', 14:50:52 INFO - 'TMOUT': '86400', 14:50:52 INFO - 'USER': 'cltbld', 14:50:52 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1482274222.659172-224554726', 14:50:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:50:52 INFO - '_': '/tools/buildbot/bin/python'} 14:50:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:50:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:50:52 INFO - Cleaning up... 14:50:52 INFO - Return code: 0 14:50:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:50:52 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')]} 14:50:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:50:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:50:52 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')]} 14:50:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:50:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:50:52 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 0x7ff6e6885f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad5f60>, '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 0x1ad6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad71d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1482274222.659172-224554726', '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 14:50:52 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 14:50:52 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 14:50:52 INFO - Using env: {'DISPLAY': ':0', 14:50:52 INFO - 'HOME': '/home/cltbld', 14:50:52 INFO - 'LANG': 'en_US.UTF-8', 14:50:52 INFO - 'LANGUAGE': 'en_US:en', 14:50:52 INFO - 'LOGNAME': 'cltbld', 14:50:52 INFO - 'MAIL': '/var/mail/cltbld', 14:50:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:50:52 INFO - 'MOZ_NO_REMOTE': '1', 14:50:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:50:52 INFO - 'NO_EM_RESTART': '1', 14:50:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:50:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:50:52 INFO - 'PWD': '/builds/slave/test', 14:50:52 INFO - 'SHELL': '/bin/bash', 14:50:52 INFO - 'SHLVL': '1', 14:50:52 INFO - 'TERM': 'linux', 14:50:52 INFO - 'TMOUT': '86400', 14:50:52 INFO - 'USER': 'cltbld', 14:50:52 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1482274222.659172-224554726', 14:50:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:50:52 INFO - '_': '/tools/buildbot/bin/python'} 14:50:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:50:52 INFO - Downloading/unpacking blobuploader==1.2.4 14:50:52 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 14:50:52 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 14:50:52 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 14:50:52 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 14:50:52 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 14:50:52 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 14:50:54 INFO - Downloading blobuploader-1.2.4.tar.gz 14:50:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:50:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:50:54 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 14:50:54 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 14:50:54 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 14:50:54 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 14:50:54 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 14:50:54 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 14:50:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:50:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:50:55 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 14:50:55 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 14:50:55 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 14:50:55 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 14:50:55 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 14:50:55 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 14:50:55 INFO - Downloading docopt-0.6.1.tar.gz 14:50:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:50:55 INFO - Installing collected packages: blobuploader, requests, docopt 14:50:55 INFO - Running setup.py install for blobuploader 14:50:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:50:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:50:55 INFO - Running setup.py install for requests 14:50:55 INFO - Running setup.py install for docopt 14:50:56 INFO - Successfully installed blobuploader requests docopt 14:50:56 INFO - Cleaning up... 14:50:56 INFO - Return code: 0 14:50:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:50:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:50:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:50:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:50:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:50:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:50:56 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 0x7ff6e6885f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad5f60>, '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 0x1ad6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad71d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1482274222.659172-224554726', '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 14:50:56 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 14:50:56 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 14:50:56 INFO - Using env: {'DISPLAY': ':0', 14:50:56 INFO - 'HOME': '/home/cltbld', 14:50:56 INFO - 'LANG': 'en_US.UTF-8', 14:50:56 INFO - 'LANGUAGE': 'en_US:en', 14:50:56 INFO - 'LOGNAME': 'cltbld', 14:50:56 INFO - 'MAIL': '/var/mail/cltbld', 14:50:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:50:56 INFO - 'MOZ_NO_REMOTE': '1', 14:50:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:50:56 INFO - 'NO_EM_RESTART': '1', 14:50:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:50:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:50:56 INFO - 'PWD': '/builds/slave/test', 14:50:56 INFO - 'SHELL': '/bin/bash', 14:50:56 INFO - 'SHLVL': '1', 14:50:56 INFO - 'TERM': 'linux', 14:50:56 INFO - 'TMOUT': '86400', 14:50:56 INFO - 'USER': 'cltbld', 14:50:56 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1482274222.659172-224554726', 14:50:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:50:56 INFO - '_': '/tools/buildbot/bin/python'} 14:50:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:50:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:50:56 INFO - Running setup.py (path:/tmp/pip-m7IlAL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:50:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:50:56 INFO - Running setup.py (path:/tmp/pip-q0aNMH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:50:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:50:56 INFO - Running setup.py (path:/tmp/pip-6weqqU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:50:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:50:56 INFO - Running setup.py (path:/tmp/pip-BCm87_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:50:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:50:56 INFO - Running setup.py (path:/tmp/pip-Bx1sXm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:50:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:50:56 INFO - Running setup.py (path:/tmp/pip-m71IcL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:50:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:50:56 INFO - Running setup.py (path:/tmp/pip-sDksnl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:50:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:50:56 INFO - Running setup.py (path:/tmp/pip-GPiNAe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:50:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:50:56 INFO - Running setup.py (path:/tmp/pip-ZXgFKs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:50:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:50:56 INFO - Running setup.py (path:/tmp/pip-wXZXZS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:50:57 INFO - Running setup.py (path:/tmp/pip-nDuOQH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:50:57 INFO - Running setup.py (path:/tmp/pip-zTiFuC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:50:57 INFO - Running setup.py (path:/tmp/pip-NNQfK5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:50:57 INFO - Running setup.py (path:/tmp/pip-HvVpOK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:50:57 INFO - Running setup.py (path:/tmp/pip-2AfgGv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:50:57 INFO - Running setup.py (path:/tmp/pip-_ntZ6K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:50:57 INFO - Running setup.py (path:/tmp/pip-krsMHP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:50:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:50:57 INFO - Running setup.py install for manifestparser 14:50:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:50:57 INFO - Running setup.py install for mozcrash 14:50:57 INFO - Running setup.py install for mozdebug 14:50:57 INFO - Running setup.py install for mozdevice 14:50:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:50:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:50:57 INFO - Running setup.py install for mozfile 14:50:58 INFO - Running setup.py install for mozhttpd 14:50:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:50:58 INFO - Running setup.py install for mozinfo 14:50:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:50:58 INFO - Running setup.py install for mozInstall 14:50:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:50:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:50:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:50:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:50:58 INFO - Running setup.py install for mozleak 14:50:58 INFO - Running setup.py install for mozlog 14:50:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:50:58 INFO - Running setup.py install for moznetwork 14:50:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:50:58 INFO - Running setup.py install for mozprocess 14:50:58 INFO - Running setup.py install for mozprofile 14:50:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:50:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:50:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:50:58 INFO - Running setup.py install for mozrunner 14:50:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:50:59 INFO - Running setup.py install for mozscreenshot 14:50:59 INFO - Running setup.py install for moztest 14:50:59 INFO - Running setup.py install for mozversion 14:50:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:50:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:50:59 INFO - Cleaning up... 14:50:59 INFO - Return code: 0 14:50:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:50:59 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')]} 14:50:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:50:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:50:59 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')]} 14:50:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:50:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:50:59 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 0x7ff6e6885f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad5f60>, '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 0x1ad6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad71d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1482274222.659172-224554726', '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 14:50:59 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 14:50:59 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 14:50:59 INFO - Using env: {'DISPLAY': ':0', 14:50:59 INFO - 'HOME': '/home/cltbld', 14:50:59 INFO - 'LANG': 'en_US.UTF-8', 14:50:59 INFO - 'LANGUAGE': 'en_US:en', 14:50:59 INFO - 'LOGNAME': 'cltbld', 14:50:59 INFO - 'MAIL': '/var/mail/cltbld', 14:50:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:50:59 INFO - 'MOZ_NO_REMOTE': '1', 14:50:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:50:59 INFO - 'NO_EM_RESTART': '1', 14:50:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:50:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:50:59 INFO - 'PWD': '/builds/slave/test', 14:50:59 INFO - 'SHELL': '/bin/bash', 14:50:59 INFO - 'SHLVL': '1', 14:50:59 INFO - 'TERM': 'linux', 14:50:59 INFO - 'TMOUT': '86400', 14:50:59 INFO - 'USER': 'cltbld', 14:50:59 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1482274222.659172-224554726', 14:50:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:50:59 INFO - '_': '/tools/buildbot/bin/python'} 14:50:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:50:59 INFO - Running setup.py (path:/tmp/pip-WUKdom-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:50:59 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)) 14:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:50:59 INFO - Running setup.py (path:/tmp/pip-RlXbxU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:50:59 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)) 14:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:50:59 INFO - Running setup.py (path:/tmp/pip-1r95uT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:50:59 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)) 14:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:50:59 INFO - Running setup.py (path:/tmp/pip-oAdysN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:50:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:50:59 INFO - Running setup.py (path:/tmp/pip-X202GT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:50:59 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)) 14:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:50:59 INFO - Running setup.py (path:/tmp/pip-4byFFX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:51:00 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)) 14:51:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:51:00 INFO - Running setup.py (path:/tmp/pip-XU_Sju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:51:00 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)) 14:51:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:51:00 INFO - Running setup.py (path:/tmp/pip-C7fxQO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:51:00 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)) 14:51:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:51:00 INFO - Running setup.py (path:/tmp/pip-r_TblW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:51:00 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)) 14:51:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:51:00 INFO - Running setup.py (path:/tmp/pip-4fZHxn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:51:00 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)) 14:51:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:51:00 INFO - Running setup.py (path:/tmp/pip-oYSgy5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:51:00 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)) 14:51:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:51:00 INFO - Running setup.py (path:/tmp/pip-DUmnl9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:51:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:51:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:51:00 INFO - Running setup.py (path:/tmp/pip-eUoQVd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:51:00 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)) 14:51:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:51:00 INFO - Running setup.py (path:/tmp/pip-u0wNGZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:51:00 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)) 14:51:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:51:00 INFO - Running setup.py (path:/tmp/pip-i3iOTX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:51:00 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)) 14:51:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:51:00 INFO - Running setup.py (path:/tmp/pip-aHkOWV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:51:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:51:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:51:00 INFO - Running setup.py (path:/tmp/pip-S_PtCf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:51:00 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)) 14:51:00 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)) 14:51:00 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)) 14:51:00 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)) 14:51:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:51:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:51:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:51:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:51:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:51:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:51:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:51:02 INFO - Downloading blessings-1.6.tar.gz 14:51:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:51:02 INFO - Installing collected packages: blessings 14:51:02 INFO - Running setup.py install for blessings 14:51:03 INFO - Successfully installed blessings 14:51:03 INFO - Cleaning up... 14:51:03 INFO - Return code: 0 14:51:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:51:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:51:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:51:03 INFO - Reading from file tmpfile_stdout 14:51:03 INFO - Current package versions: 14:51:03 INFO - argparse == 1.2.1 14:51:03 INFO - blessings == 1.6 14:51:03 INFO - blobuploader == 1.2.4 14:51:03 INFO - docopt == 0.6.1 14:51:03 INFO - functools32 == 3.2.3-2 14:51:03 INFO - jsonschema == 2.5.1 14:51:03 INFO - manifestparser == 1.1 14:51:03 INFO - mozInstall == 1.12 14:51:03 INFO - mozcrash == 1.0 14:51:03 INFO - mozdebug == 0.1 14:51:03 INFO - mozdevice == 0.48 14:51:03 INFO - mozfile == 1.2 14:51:03 INFO - mozhttpd == 0.7 14:51:03 INFO - mozinfo == 0.9 14:51:03 INFO - mozleak == 0.1 14:51:03 INFO - mozlog == 3.4 14:51:03 INFO - moznetwork == 0.27 14:51:03 INFO - mozprocess == 0.23 14:51:03 INFO - mozprofile == 0.28 14:51:03 INFO - mozrunner == 6.13 14:51:03 INFO - mozscreenshot == 0.1 14:51:03 INFO - mozsystemmonitor == 0.3 14:51:03 INFO - moztest == 0.7 14:51:03 INFO - mozversion == 1.4 14:51:03 INFO - psutil == 3.1.1 14:51:03 INFO - requests == 1.2.3 14:51:03 INFO - wsgiref == 0.1.2 14:51:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:51: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')]} 14:51:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51: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')]} 14:51:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:03 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 0x7ff6e6885f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad5f60>, '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 0x1ad6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad71d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1482274222.659172-224554726', '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 14:51:03 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 14:51:03 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 14:51:03 INFO - Using env: {'DISPLAY': ':0', 14:51:03 INFO - 'HOME': '/home/cltbld', 14:51:03 INFO - 'LANG': 'en_US.UTF-8', 14:51:03 INFO - 'LANGUAGE': 'en_US:en', 14:51:03 INFO - 'LOGNAME': 'cltbld', 14:51:03 INFO - 'MAIL': '/var/mail/cltbld', 14:51:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:03 INFO - 'MOZ_NO_REMOTE': '1', 14:51:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:51:03 INFO - 'NO_EM_RESTART': '1', 14:51:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:51:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:51:03 INFO - 'PWD': '/builds/slave/test', 14:51:03 INFO - 'SHELL': '/bin/bash', 14:51:03 INFO - 'SHLVL': '1', 14:51:03 INFO - 'TERM': 'linux', 14:51:03 INFO - 'TMOUT': '86400', 14:51:03 INFO - 'USER': 'cltbld', 14:51:03 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1482274222.659172-224554726', 14:51:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:03 INFO - '_': '/tools/buildbot/bin/python'} 14:51:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:03 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)) 14:51:03 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)) 14:51:03 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)) 14:51:03 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)) 14:51:03 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)) 14:51:03 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)) 14:51:03 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)) 14:51:03 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)) 14:51:03 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)) 14:51:03 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)) 14:51:03 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)) 14:51:03 INFO - Cleaning up... 14:51:03 INFO - Return code: 0 14:51:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:51: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')]} 14:51:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51: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')]} 14:51:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6e6885f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad5f60>, '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 0x1ad6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad71d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1482274222.659172-224554726', '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 14:51: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', 'jsonschema'] in /builds/slave/test/build 14:51: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 jsonschema 14:51:03 INFO - Using env: {'DISPLAY': ':0', 14:51:03 INFO - 'HOME': '/home/cltbld', 14:51:03 INFO - 'LANG': 'en_US.UTF-8', 14:51:03 INFO - 'LANGUAGE': 'en_US:en', 14:51:03 INFO - 'LOGNAME': 'cltbld', 14:51:03 INFO - 'MAIL': '/var/mail/cltbld', 14:51:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:03 INFO - 'MOZ_NO_REMOTE': '1', 14:51:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:51:03 INFO - 'NO_EM_RESTART': '1', 14:51:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:51:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:51:03 INFO - 'PWD': '/builds/slave/test', 14:51:03 INFO - 'SHELL': '/bin/bash', 14:51:03 INFO - 'SHLVL': '1', 14:51:03 INFO - 'TERM': 'linux', 14:51:03 INFO - 'TMOUT': '86400', 14:51:03 INFO - 'USER': 'cltbld', 14:51:03 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1482274222.659172-224554726', 14:51:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:03 INFO - '_': '/tools/buildbot/bin/python'} 14:51:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:51:03 INFO - Cleaning up... 14:51:03 INFO - Return code: 0 14:51:03 INFO - Running post-action listener: _resource_record_post_action 14:51:03 INFO - Running post-action listener: _start_resource_monitoring 14:51:03 INFO - Starting resource monitoring. 14:51:03 INFO - [mozharness: 2016-12-20 22:51:03.802598Z] Finished create-virtualenv step (success) 14:51:03 INFO - [mozharness: 2016-12-20 22:51:03.803162Z] Running install step. 14:51:03 INFO - Running pre-action listener: _resource_record_pre_action 14:51:03 INFO - Running main action method: install 14:51:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:51:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:51:04 INFO - Reading from file tmpfile_stdout 14:51:04 INFO - Detecting whether we're running mozinstall >=1.0... 14:51:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:51:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:51:04 INFO - Reading from file tmpfile_stdout 14:51:04 INFO - Output received: 14:51:04 INFO - Usage: mozinstall [options] installer 14:51:04 INFO - Options: 14:51:04 INFO - -h, --help show this help message and exit 14:51:04 INFO - -d DEST, --destination=DEST 14:51:04 INFO - Directory to install application into. [default: 14:51:04 INFO - "/builds/slave/test"] 14:51:04 INFO - --app=APP Application being installed. [default: firefox] 14:51:04 INFO - mkdir: /builds/slave/test/build/application 14:51:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:51:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:51:20 INFO - Reading from file tmpfile_stdout 14:51:20 INFO - Output received: 14:51:20 INFO - /builds/slave/test/build/application/firefox/firefox 14:51:20 INFO - Running post-action listener: _resource_record_post_action 14:51:20 INFO - [mozharness: 2016-12-20 22:51:20.013182Z] Finished install step (success) 14:51:20 INFO - [mozharness: 2016-12-20 22:51:20.013426Z] Running run-tests step. 14:51:20 INFO - Running pre-action listener: _resource_record_pre_action 14:51:20 INFO - Running main action method: run_tests 14:51:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:51:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:51:20 INFO - Python 2.7.3 14:51:20 INFO - Return code: 0 14:51:20 INFO - grabbing minidump binary from tooltool 14:51:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:51:20 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 0x1ad5f60>, '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 0x1ad6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad71d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:51:20 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 14:51:20 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 14:51:20 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 14:51:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:51:20 INFO - Return code: 0 14:51:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:51:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:51:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:51:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:51:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:51:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e7Row3e3Q8avAgCiBVqB2Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:51:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/e7Row3e3Q8avAgCiBVqB2Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-049 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:51:20 INFO - Using env: {'DISPLAY': ':0', 14:51:20 INFO - 'HOME': '/home/cltbld', 14:51:20 INFO - 'LANG': 'en_US.UTF-8', 14:51:20 INFO - 'LANGUAGE': 'en_US:en', 14:51:20 INFO - 'LOGNAME': 'cltbld', 14:51:20 INFO - 'MAIL': '/var/mail/cltbld', 14:51:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:51:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:51:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:20 INFO - 'MOZ_NO_REMOTE': '1', 14:51:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:51:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:51:20 INFO - 'NO_EM_RESTART': '1', 14:51:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:51:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:51:20 INFO - 'PWD': '/builds/slave/test', 14:51:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:51:20 INFO - 'SHELL': '/bin/bash', 14:51:20 INFO - 'SHLVL': '1', 14:51:20 INFO - 'TERM': 'linux', 14:51:20 INFO - 'TMOUT': '86400', 14:51:20 INFO - 'USER': 'cltbld', 14:51:20 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1482274222.659172-224554726', 14:51:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:20 INFO - '_': '/tools/buildbot/bin/python'} 14:51:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e7Row3e3Q8avAgCiBVqB2Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:51:20 INFO - mozversion application_buildid: 20161220131053 14:51:20 INFO - mozversion application_changeset: 1e46434c7b43128830f1cd34b4372c06366912ee 14:51:20 INFO - mozversion application_display_name: FirefoxDeveloperEdition 14:51:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:51:20 INFO - mozversion application_name: Firefox 14:51:20 INFO - mozversion application_remotingname: firefox-dev 14:51:20 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:51:20 INFO - mozversion application_vendor: Mozilla 14:51:20 INFO - mozversion application_version: 52.0a2 14:51:20 INFO - mozversion platform_buildid: 20161220131053 14:51:20 INFO - mozversion platform_changeset: 1e46434c7b43128830f1cd34b4372c06366912ee 14:51:20 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:51:20 INFO - mozversion platform_version: 52.0a2 14:51:20 INFO - using testdate: 1482274280 14:51:20 INFO - actual date: 1482274280 14:51:20 INFO - starting webserver on 'localhost:36434' 14:51:20 INFO - SUITE-START | Running 2 tests 14:51:20 INFO - TEST-START | dromaeo_css 14:51:20 INFO - operating with platform_type : linux_ 14:51:20 INFO - Initialising browser for dromaeo_css test... 14:51:20 INFO - TEST-INFO | started process 6652 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp49tQan/profile http://localhost:36434/getInfo.html) 14:51:24 INFO - PROCESS | 6652 | __metrics Screen width/height:1600/1200 14:51:24 INFO - PROCESS | 6652 | colorDepth:24 14:51:24 INFO - PROCESS | 6652 | Browser inner width/height: 1024/697 14:51:24 INFO - PROCESS | 6652 | __metrics 14:51:24 INFO - PROCESS | 6652 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:51:24 INFO - PROCESS | 6652 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:51:25 INFO - PROCESS | 6652 | console.error: PushService: 14:51:25 INFO - PROCESS | 6652 | stateChangeProcessEnqueue: Error transitioning state 14:51:25 INFO - PROCESS | 6652 | UnknownError 14:51:25 INFO - TEST-INFO | 6652: exit 0 14:51:25 INFO - Browser initialized. 14:51:25 INFO - Running cycle 1/1 for dromaeo_css test... 14:51:25 INFO - TEST-INFO | started process 6747 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp49tQan/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:51:37 INFO - PROCESS | 6747 | RSS: Main: 147972096 14:51:37 INFO - PROCESS | 6747 | 14:52:29 INFO - PROCESS | 6747 | 1482274349318 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:54:39 INFO - PROCESS | 6747 | Cycle 1(1): loaded http://localhost:36434/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36434/tests/dromaeo/cssquery-ext.html) 14:54:40 INFO - PROCESS | 6747 | RSS: Main: 243130368 14:54:40 INFO - PROCESS | 6747 | 14:57:43 INFO - PROCESS | 6747 | Cycle 1(1): loaded http://localhost:36434/tests/dromaeo/cssquery-ext.html (next: http://localhost:36434/tests/dromaeo/cssquery-jquery.html) 14:57:43 INFO - PROCESS | 6747 | RSS: Main: 238305280 14:57:43 INFO - PROCESS | 6747 | 15:00:45 INFO - PROCESS | 6747 | Cycle 1(1): loaded http://localhost:36434/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36434/tests/dromaeo/cssquery-mootools.html) 15:00:46 INFO - PROCESS | 6747 | RSS: Main: 208121856 15:00:46 INFO - PROCESS | 6747 | 15:03:48 INFO - PROCESS | 6747 | Cycle 1(1): loaded http://localhost:36434/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36434/tests/dromaeo/cssquery-prototype.html) 15:03:48 INFO - PROCESS | 6747 | RSS: Main: 176181248 15:03:48 INFO - PROCESS | 6747 | 15:06:51 INFO - PROCESS | 6747 | Cycle 1(1): loaded http://localhost:36434/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36434/tests/dromaeo/cssquery-yui.html) 15:06:52 INFO - PROCESS | 6747 | RSS: Main: 179900416 15:06:52 INFO - PROCESS | 6747 | 15:09:54 INFO - PROCESS | 6747 | Cycle 1(1): loaded http://localhost:36434/tests/dromaeo/cssquery-yui.html (next: http://localhost:36434/tests/dromaeo/cssquery-dojo.html) 15:09:54 INFO - PROCESS | 6747 | RSS: Main: 275296256 15:09:54 INFO - PROCESS | 6747 | 15:09:54 INFO - PROCESS | 6747 | __start_tp_report 15:09:54 INFO - PROCESS | 6747 | _x_x_mozilla_page_load 15:09:54 INFO - PROCESS | 6747 | _x_x_mozilla_page_load_details 15:09:54 INFO - PROCESS | 6747 | |i|pagename|runs| 15:09:54 INFO - PROCESS | 6747 | |0;dojo.html;3156.2267244525087;3200.103970888152;3210.406074876148;3224.7097761201485;3233.175540237239;5437.592180586457;5460.808871689486;5515.779368825252;5542.196381524676;5566.8329950101515;5578.86052848679;5593.8601534961645;5595.21666966625;5604.822987172688;5608;5054;5082.542571168594;5107.310513080743;5114.820981265657;5116.769745361467;4983.252512123175;5135.666181698196;5155.639105262633;5172.379314482268;5186.455422180673;4982.028504441635;4996.950030499703;5016.44819069902;5027.698338099707;5055.443901170868;5099.311592934962;5113.769880355393;5135.281060651511;5178.559822415099;5183.300254465675;5005.849824505271;5081.2632168335385;5123.641345105844;5140.3060586820675;5163.1480805667015;5369.060414427459;5419.376771671269;5434.239206511092;5497.697626630534;5523.530499907512;5859.8535036624;5860.648361098348;5878.118282257653;5967.075103358986;5970;6005.1892994445625;6007.15899774032;6015;6017.909731354033;6021.066734656135;5413.296271484721;5441.102218134003;5509.201165830932;5565.276514053228;5571.804986825523;6081.787137450168;6102.084687296941;6114.052321890114;6119.9902016167725;6122.448979591858;5863.208466857005;5878.970605146947;5885.646861188342;5887.0580707086665;5897.262842144732;5814.04068328721;5868.970655146697;5929.199558059607;5970.194023806817;5982.850428739229;5974.492168165754;5977.372375900555;5980.983232850426;5997.370276121032;6036.879262414727;5979.790707325223;6016.608920420159;6027.638341699512;6030.18592490017;6030.396960303934;4550.362949187116;4565.931511027337;4608.516105808909;4613.884652883705;4678.532146785295;4092.7748973806133;4129.566395528426;4140.565240649748;4155.231282212801;4173.937390939138;5631.2960879890015;5637.633553819071;5647.068233741386;5648.096304591246;5651.095824668033;5779.971100144472;5852.853678658068;5886.58793884424;5983.521318294526;5985.042393217152;5551.056320425457;5596.804111856066;5600.383957764642;5626.212330273765;5626.831195064155;5146.691198528026;5147.6396652234735;5153.3558305211845;5155.664881782672;5190.480951904779;5840.328362238227;5953.196318496947;6095.05526643371;6095.390460953958;6105.664188469588;5895.115732639967;5913;5950.19672344228;6030.366811484906;6059.969700151471;6103.389661033861;6130.325664177026;6130.816075517741;6135.417135372132;6135.7238924249405;5676.120201368794;5893.5874488785375;5910.615809972338;5913.34953155144;5913.526917846648;5752.68360240174;5871.7651293947765;5877.089051197071;5918.496927761016;5958.553108516792;5765.279340082489;5806.564507662027;5811.738471768696;5815.011448053757;5821.825345239649;5772.307323121252;5781.653100813965;5782.45066718661;5788.479036886701;5790.247267855152;5567.4432556744005;5582.860428489158;5638.126090455986;5742.109972954198;5747.9137812932;5874.236349274567;5877.706114694333;5882.117682347682;5898.587098903035;5899.587028907935;5526.171074338881;5576.079946808731;5720.199172115824;5721.399253078534;5730 15:09:54 INFO - PROCESS | 6747 | |1;ext.html;569.6183557016799;602.6354055796243;608.115192395065;641.9069234960928;655.2497390487895;33625.1593710157;43378.56621433785;43651.56348436515;43832.34251486226;43848.56151438485;44274;44526.55473445264;44639;44644;44646.77676611621;8293;8887.111288871125;9025.909740902605;9030.954845225764;9037.95481022594;8273.296769774577;10515.421651809147;10745.78508429831;10799.352038877652;11092.722681932975;10897.564097436092;10965.067969222626;10966.506507207196;10970.835437468444;10974.396408197546;10828.296160749565;10919.454027298603;10921.890781092166;10926.453677316102;10965.671029869116;10814.405207713573;10861.511231994578;10879.401632910187;10886.40124793136;10890.183236257233;42520.66136362499;42866.57133428657;42870;42887.35668964968;42961.14077718459;3762.962370376316;4025.677945764332;4297.290946993742;4353.390525326457;4410.558944105596;31985.52021719676;32426.67573324284;32704.182395440068;32821.507677384856;33259.6674033259;3638.399664055428;3650;3685.7972811495356;3731.2350968051483;3799.1072098056934;359444;359616;360009;360174;360370;38115.61884381176;52020;52101.7394913023;52278.738606306724;52312.21531677028;39359.60640393559;41573;41603;41603.7919810399;41619.583804162176;15135.56212159843;15150.848491515164;15159.166245856362;15160.545183644508;15168.848311516964;12497.312647804458;13012.869871301165;13205.801912971314;14050.718985620231;14197;9503.57233924475;9672;9697.806043879084;9745.220382369393;9752;3516.4197907345515;3578.499010138583;3618.3125206210734;3638.6361363863402;3667.64297210034;1034.9741256468499;1070.8019016481976;1114.3648120571197;1128.2384390536356;1146.3179408252076;31692.937910825538;33500.49749253763;33885.32229355448;34115.82942085274;34420;1090.4493230918495;1101.581399068349;1135.103268417957;1142.6686260984388;1150.6605551362368;16275.186240687919;17315.56711082233;17394.826051739572;17441.912790435967;17542.122893855256;568353;570695;571905;573867;577125;59449.40550594525;59516;59563.70218148968;60020.399796002355;60107;1293.502001729341;1350.1966330033615;1416.9433222670978;1448.9058211216238;1449.463698431587;30897.382052358378;33564.832175838965;34069.48895766516;34575.82712086423;34852.128696782784;51000;57089.42910571007;58817.70591147188;58846.41153588409;64823.351766481734;410861;414487;414836;416316;416814;30266.69733302727;30401.543976840807;30404.847975759978;32810;44297;50398.49601503938;50511.49488505068;50738.98522029465;50800;52031.73984130055;41744.1651166981;42366.152676946906;42395.09222084952;43800.342994854465;44236;42027.57972420237;42318.57681423269;42342.57657423509;42394.78802605967;44290.11419771522;41132;41599.7920010398;41697.583024170584;47300.29049564328;48067;43943.198804185355;45505.77247113743;45698.31452528148;46119.3082103762;47066.52933470622;36240.45639315465;36893.631063690096;37020.814895925345;37109.443358349105;37181.81409092937 15:09:54 INFO - PROCESS | 6747 | |2;jquery.html;387.33765261403;399.5105995155934;410.3147743268741;422.66820545871485;430.4576233945228;15498.457553985612;19871;20034.49913752157;20044.69932951007;20588.48528786781;13618.659533511667;13824.654383640414;15740.898137130405;20052.1979120835;20713.171473141058;4800.783964721596;5315.760790764405;5479.315085614298;5525.281713377255;5527.585431092664;5956.434138756811;6078.118672792442;6079.756809727605;6102.206713127287;6103.23709536308;5992.430719081702;6089.78685745999;6094.146819445281;6553.836154096162;6583.9670801645925;6547.3125321841235;6562.803115906483;6581.605103693793;6582.967085164568;6587.242467116295;5183.585313174937;5429.914017196537;5453.4273901240595;5492.121260598325;5515.09001014832;14870.628234294121;15061.397544098223;15100.773488397683;15122.621934451618;15269.160196189205;2381.9047238110456;2702.50003749307;2994.191568276575;3009.1574359179244;3099.736522395599;10860.185486088574;11095.611653592085;11128.443577821077;11900.880991190064;15312.157831319273;1876.6246750649789;1927.4603111128906;1977.2881762565464;2006.1373609347975;2060.2789023841688;84624.57687711583;85618.14381856164;86328;86522.56738716329;86655;11794.646160615195;11862.110341724405;12115.515379384726;12142.210756300812;12175.634730958085;17137.05746183972;17139.657206855794;17149.485515434557;17163.227654755567;17200.881942673685;7270.527415717961;7285.817854553678;7288.8177795554475;7959.084705258853;8831.116888311246;8465.449745766506;8475.194856488624;8518.57407129641;8704.303655707528;8755.605997730117;5114.897702045938;5153.201253805666;5166.81916132941;5189.040027594907;5281.788728450819;2017.3544465770813;2062.3400511836066;2076.6988786625857;2095.5808838232415;2100.2334148035857;925.4632313258294;960.0687333286701;1003.508280942333;1013.7719013222113;1019.3425240719695;19639.901800490905;19835.305764298468;20004.49988750293;20215.696764548542;20394.49013774638;1028.3058935218698;1030.217035053365;1034.8033873564;1052.137247457093;1098.8846171152074;10358.637447689294;11178.826223246604;11202.159838012181;11353;11393.772124557463;471489;473383;491995;529228;531153;96927;98097;99067.50466247767;99255;100327.49836250771;996.531630133836;1026.97432564185;1035.233926894093;1060.0035966191908;1067.1196263082988;17140.40008599693;17438.47684569465;17807.821921781135;17843.286268549113;18049.278028879224;41298.79350603228;41917.79041104775;41932.37101443542;42113.15773684448;43235.783821080695;58640;59011.40988590231;59210.70394647999;60564;60594.69702651635;8567.048966691305;8978;9192.080791921022;9244.676436324697;9441.197498212729;12835.679108022374;12859.678508037;12880.35598220104;13404.731905361643;13479.258640774851;11396;11421.543138274375;12055.879441205476;12127.211731237441;12379.504819807107;11410.657680269605;11465;11890.881091189323;11991.561012678534;12351.073669475005;11527.423628818693;11962.401879906143;11974.880251197377;12307.815382769086;12371.505139794308;8708.60811263482;8949.552522373986;9016.18854303116;9302.534873256174;9456.101670341306;9183.908160918305;11238;11582.420878956187;11741;11807.940960295144 15:09:54 INFO - PROCESS | 6747 | |3;mootools.html;1414.5614859393581;1501.1668523969192;1534.6547026918943;1648.8705236912708;1789.8210178982094;7658.119316278629;8004.159563245863;8227.753167404973;8253.133420990793;8477.279431248337;8290.58547072647;8367.414281000332;8369.246767790897;8381.371397145209;8381.958090209555;2376.0495801679294;2392.3301475586863;2393.617021276596;2394.4971555973266;2398.5322862041908;2371.988140059306;2418.9274321770376;2447.8898449569724;2448.52253810507;2448.7306396296394;2367.4199821043867;2405.1461731085474;2410.4937963027696;2413.372523143986;2434.221049264236;2325.616273314901;2337.836351455399;2361.822863285252;2362.799162071226;2362.799162071226;2302.3783578433895;2376.263358358914;2395.9401014974765;2397.880105994693;2398.07674045492;7649.655765490566;7827.099883513412;8302;8349.791255218608;8408.789780255482;4970.87572810679;5120.718360490171;5130.563902068328;5133.30700355451;5156.74216289184;3407.30150319184;3426.1605906552804;3502.1594817243677;3514.3674138655033;3522.5772907251294;1161.7211869151427;1166.7374840660868;1176.5176277726177;1198.1373411143963;1216.6471723200261;12044.096692748079;12079.154459187861;12079.93960030203;12085.274883507105;12085.45615447307;4451.732896026184;4706.458757242961;4741.383620129361;4834.95165048352;4843.709377437365;9630.374025688308;9633.277504187214;9634.229261659051;9638.95180524107;9669.129778319984;5202;5217.34783152106;5218.243354713545;5234.18870075139;5241.42344342122;4787.640926930494;4813.470518242991;4833.734144622009;5045.621578381562;5103.106956282636;3994.4807175067635;4074.5314288856566;4074.5517993020744;4144.772037537964;4184.205001049791;1356.1659579358623;1367.234348764695;1397.0569865340854;1398.5314919501877;1400.2788563889605;942.528735632184;953.7043516509765;956.1108169402384;956.7751578379075;982.1160955140431;5634.774609015675;5742.885142297131;5772.076467765138;5788.131780232999;5939.13882487037;480.89660722944734;496.3026947139275;499.4106953794485;500.3445486412811;508.13870489520644;3894.941575876364;3918.1184233547224;3920.2159568086495;3942.4283478895973;4029.435878976946;10158.949205253926;10813.243072984973;10865.728356790985;10872.238943273895;10872.61945831892;10457.477126143815;10680.78638427227;10694.35833849956;10715.571377144826;10718.249722519504;8200.466969646954;8315.83368332642;8333.166683331618;8335.083140854502;8337.374696897758;5521.861953451196;5660.660360378391;5666.546676265806;5691.345495268097;5801.1878337033695;9907.653232136841;9910.058544438267;9954.701358959242;10019.398836069859;10032.097111259729;9949;10153.949230253802;10173.338732982333;10269.537870795682;10273.178145748172;7825.373970082266;7874.803129921798;7906.960465197637;7919.722809701633;7921.32668723165;8283.710070147516;8341.165883411853;8468.153184681483;8479.95760021196;8491.702790402307;7553.546787192786;7614;7652.961735191288;7673.808154796175;7784.065912090586;7652.081750190013;7690.461667683208;7694.269044440769;7718.884216736866;7814;6625.304343044104;6734.764283250062;6785.321467853175;6791.117154769849;6805.251422343439;4693.272542755878;4777.761111944319;4850.417949846041;4875.976045030583;5040.773165207501;4312.676549258756;4933.1613625683;4971.229459433794;4992.525710057539;5095.414027386898 15:09:54 INFO - PROCESS | 6747 | |4;prototype.html;352.18117875938435;353.318096074576;356.2038843185481;363.1321142469497;372.75584492157645;5474.534664553513;5489.149181876811;5506.366767821702;5524.806631767889;5557.5831812614115;5385.946140538594;5413.458654134584;5449.264349312842;5453.127499600065;5468.3711373192;4180.644645205161;4269.893252668677;4282.807273672676;4295.656347492193;4302.354646802989;4254.872353829374;4261.595148460891;4266.765327906964;4290.356446533014;4303.053328267776;4043.615856493643;4259.5740425957465;4265.104328091104;4292.969687275047;4310.762908040057;4150.418941348214;4153.107081977374;4222.134462435193;4241.809118589671;4260.829566817323;3810.942835857464;3814.408766641175;3819.4461803038403;3819.598942111094;3850.998740327507;5040.974795126001;5171.22431635254;5187.974060129675;5220.425753167148;5235.397929238148;4720.622350211975;4842.394700662418;4888.560029597318;4893.168161412568;4903.411590609114;5629.662220266797;5638.238837756891;5644.6330988485615;5653.830385088454;5667.206591077253;4157.147784704129;4250.277452832995;4264.530901600821;4264.786760661955;4274.29474136767;5772.480476757112;5796.739146738365;5810.1865738796605;5821.388754180793;5823.184754134425;4344.391785150082;4356.6950313477755;4364.8214981955325;4371.497277813029;4411.117776444724;4178.7283826551175;4370.628496577763;4391.738254798781;4462.620677242406;4465.013069184181;4855.830045948375;4856.587190088882;4867.367242258484;4891;4895.33912921751;5657.632253903483;5686.431356864363;5692.402297758758;5700.116481945305;5725.370209276976;1451.2163431746949;1469.7427950108902;1474.1965628732366;1478.3125846481437;1480;1027.814993301213;1030.283952652899;1036.7770929250248;1053.3837704942541;1059.232056758859;5181.26427646735;5282.947170528322;5294.311739473921;5298.311219541435;5308.416074231832;5493.340799104053;5532.7039278698885;5558.388577256498;5577.2191893135;5591.412901645269;5093.541581257705;5269.499397557226;5273.785010295685;5383.627175070332;5464.781408743605;2940.2355387599378;2944.7926350196317;2959.896403625906;2962.511185654343;2979.9851000744857;5562.137868630369;5636.323641163087;5691.886162276731;5730.914036289459;5733.483986441241;5627.606067575231;5663.40373862592;5697.971510142423;5706.889745088936;5721.8569535761935;5680.517156041783;5683.630564013326;5684.516816070681;5703.258576385127;5725.4274572543245;5313.229581710708;5611.38274789781;5630.901974115009;5662.320521537442;5669.659820410789;5538.944610553843;5557.416471270459;5579.525740312119;5581.376752926119;5581.553475722014;5388.838334849961;5667.716614169358;5675.091985282335;5701.971490142523;5718.285214348207;4177.394277829637;4197.412362269224;4205.537390886939;4210.578942105765;4217.051163488313;5576.358718747396;5578.772670012753;5584.609077364546;5590.133529302964;5636.436356364331;5376.274202982704;5470.562355011669;5489.972550137224;5497.725113744217;5569.749361278671;5456.48163424474;5477.260569823182;5502.862428439321;5504.724763761716;5512.318742783329;5367.463253674601;5372.221027951004;5385.441915090458;5429.728513574384;5476.726163691879;5235.3717553893775;5395.678058875444;5443.918341224964;5530.834074977596;5549.889002219852;5380;5382.919256211082;5384.19237114436;5392.272043274108;5403.567714582902 15:09:54 INFO - PROCESS | 6747 | |5;yui.html;772.4669977715376;778.2101167315175;787.9881801772971;795.041974420823;882.9249513791327;14459.855401445982;15209.619759506004;15344.61638459039;16177.35290588375;16377.42679006235;13689.65775855604;14502.129872207675;14563.126212427236;14655.120692758415;14733.778993315109;849.8682704180862;871.0070519607652;873.5894129759004;877.32007694037;879.0462348352014;864.2826454043161;865.7965378136133;867.3928250224836;867.4751775176022;868.4008034456205;921.2952091649893;922.2667978956712;922.916937475627;923.0400383601046;923.8383282925495;911.3620465674021;912.0788004115824;912.7991841794794;912.8402529557368;912.8904531456201;671.1208317104608;671.516508114157;672.5191488085993;672.9158855143107;673.1148539670318;14699.485518006819;15181.620459488491;15257.694846103015;15490.457833975757;15692.529224123295;14567.708645827024;14747.188904610242;15197.544073677696;15252.847471525365;15265.61835954099;11563.421828908606;11695.298282103102;11971.162018658697;12340.753184936251;12776.42506087219;3883.165119499321;3890.8443662253476;3896.649301562873;3916.8824935251987;4029.315016447211;64537.354626453605;65391.67304163496;66907.33092669108;67310;68602;11351.545938162546;11425.021741831284;11517.942410288062;11550.249233799776;11654.184207105422;20094.296699615443;20116.89941550283;20199;20232.797672023386;20620.58758824845;8189.426740128134;8377.874331885027;8461.323094152453;8638;8638.568071596395;4944.728039957837;4969.478204788517;5025.39695236574;5045.596352291881;5088.796448142033;3608.6030536640947;3737.972057684104;3740.663340299386;3741.251749650081;3741.270452261783;647.1005302629349;651.3519048546726;654.2737561306946;660.3561527510639;661.6493258572964;756.9545827250382;774.5043172369687;806.2179685704857;807.2774866494454;809.3767798794895;9806.803863922823;10222.744431389276;10293.74265643365;10459.110975567162;10815.134789216843;730.4850080693204;774.7830607429929;780.286038274972;782.5578548120294;796.2873228460611;4583.72497650142;4586.151561960981;4609.193391156534;4654.953450465519;4698.976505117453;74996.62501687456;75757;79558.60220698976;83606.581967091;83720;46393;52717;54495.45504544904;60629.69685151634;70741.2925870745;67797.3220267791;67917.66041169762;68291.65854170697;68300.3169968294;68705;9709.805803884024;9729.648991784914;9880.45657488845;10002.699919002442;10101.292909496266;33436.164095897795;37994.43008354821;41072.1785564293;45282;47361.7631911852;42085;42381.576184239;44165.33751993787;58801.4119858796;61136.38863611307;12922.160059596095;13227.867721322664;13374.665633359244;13535.323233838466;13565.864341356855;14108.645448333342;14566.198859062853;14781.778273325694;14832.629184270048;15019.924900375428;13922.51271205503;13950.302484875512;14174.362153703314;14818.481353152589;14974;13633.863661363655;13644.590662280147;13859.653508662364;14290.285485725464;14982.700345993237;12762.936185319015;13018.088733788543;13142.211467311992;13333.466661333438;14078.436862525385;10728.785424291314;10791.56833726642;10823.621173258898;11558.49230175752;11716.121290903387;9888.802223955337;10671.519781609692;10925;11094.722631934266;11246.493907774005 15:09:54 INFO - PROCESS | 6747 | __end_tp_report 15:09:54 INFO - PROCESS | 6747 | __start_cc_report 15:09:54 INFO - PROCESS | 6747 | _x_x_mozilla_cycle_collect,1038 15:09:54 INFO - PROCESS | 6747 | __end_cc_report 15:09:54 INFO - PROCESS | 6747 | __startTimestamp1482275394823__endTimestamp 15:09:54 INFO - PROCESS | 6747 | 15:09:54 INFO - PROCESS | 6747 | ------- Summary: start ------- 15:09:54 INFO - PROCESS | 6747 | Number of tests: 6 15:09:54 INFO - PROCESS | 6747 | 15:09:54 INFO - PROCESS | 6747 | [#0] dojo.html Cycles:165 Average:5522.69 Median:5721.40 stddev:611.90 (10.7%) stddev-sans-first:584.94 15:09:54 INFO - PROCESS | 6747 | Values: 3156.2 3200.1 3210.4 3224.7 3233.2 5437.6 5460.8 5515.8 5542.2 5566.8 5578.9 5593.9 5595.2 5604.8 5608.0 5054.0 5082.5 5107.3 5114.8 5116.8 4983.3 5135.7 5155.6 5172.4 5186.5 4982.0 4997.0 5016.4 5027.7 5055.4 5099.3 5113.8 5135.3 5178.6 5183.3 5005.8 5081.3 5123.6 5140.3 5163.1 5369.1 5419.4 5434.2 5497.7 5523.5 5859.9 5860.6 5878.1 5967.1 5970.0 6005.2 6007.2 6015.0 6017.9 6021.1 5413.3 5441.1 5509.2 5565.3 5571.8 6081.8 6102.1 6114.1 6120.0 6122.4 5863.2 5879.0 5885.6 5887.1 5897.3 5814.0 5869.0 5929.2 5970.2 5982.9 5974.5 5977.4 5981.0 5997.4 6036.9 5979.8 6016.6 6027.6 6030.2 6030.4 4550.4 4565.9 4608.5 4613.9 4678.5 4092.8 4129.6 4140.6 4155.2 4173.9 5631.3 5637.6 5647.1 5648.1 5651.1 5780.0 5852.9 5886.6 5983.5 5985.0 5551.1 5596.8 5600.4 5626.2 5626.8 5146.7 5147.6 5153.4 5155.7 5190.5 5840.3 5953.2 6095.1 6095.4 6105.7 5895.1 5913.0 5950.2 6030.4 6060.0 6103.4 6130.3 6130.8 6135.4 6135.7 5676.1 5893.6 5910.6 5913.3 5913.5 5752.7 5871.8 5877.1 5918.5 5958.6 5765.3 5806.6 5811.7 5815.0 5821.8 5772.3 5781.7 5782.5 5788.5 5790.2 5567.4 5582.9 5638.1 5742.1 5747.9 5874.2 5877.7 5882.1 5898.6 5899.6 5526.2 5576.1 5720.2 5721.4 5730.0 15:09:54 INFO - PROCESS | 6747 | 15:09:54 INFO - PROCESS | 6747 | [#1] ext.html Cycles:180 Average:61215.35 Median:38737.61 stddev:121494.66 (313.6%) stddev-sans-first:121750.16 15:09:54 INFO - PROCESS | 6747 | Values: 569.6 602.6 608.1 641.9 655.2 33625.2 43378.6 43651.6 43832.3 43848.6 44274.0 44526.6 44639.0 44644.0 44646.8 8293.0 8887.1 9025.9 9031.0 9038.0 8273.3 10515.4 10745.8 10799.4 11092.7 10897.6 10965.1 10966.5 10970.8 10974.4 10828.3 10919.5 10921.9 10926.5 10965.7 10814.4 10861.5 10879.4 10886.4 10890.2 42520.7 42866.6 42870.0 42887.4 42961.1 3763.0 4025.7 4297.3 4353.4 4410.6 31985.5 32426.7 32704.2 32821.5 33259.7 3638.4 3650.0 3685.8 3731.2 3799.1 359444.0 359616.0 360009.0 360174.0 360370.0 38115.6 52020.0 52101.7 52278.7 52312.2 39359.6 41573.0 41603.0 41603.8 41619.6 15135.6 15150.8 15159.2 15160.5 15168.8 12497.3 13012.9 13205.8 14050.7 14197.0 9503.6 9672.0 9697.8 9745.2 9752.0 3516.4 3578.5 3618.3 3638.6 3667.6 1035.0 1070.8 1114.4 1128.2 1146.3 31692.9 33500.5 33885.3 34115.8 34420.0 1090.4 1101.6 1135.1 1142.7 1150.7 16275.2 17315.6 17394.8 17441.9 17542.1 568353.0 570695.0 571905.0 573867.0 577125.0 59449.4 59516.0 59563.7 60020.4 60107.0 1293.5 1350.2 1416.9 1448.9 1449.5 30897.4 33564.8 34069.5 34575.8 34852.1 51000.0 57089.4 58817.7 58846.4 64823.4 410861.0 414487.0 414836.0 416316.0 416814.0 30266.7 30401.5 30404.8 32810.0 44297.0 50398.5 50511.5 50739.0 50800.0 52031.7 41744.2 42366.2 42395.1 43800.3 44236.0 42027.6 42318.6 42342.6 42394.8 44290.1 41132.0 41599.8 41697.6 47300.3 48067.0 43943.2 45505.8 45698.3 46119.3 47066.5 36240.5 36893.6 37020.8 37109.4 37181.8 15:09:54 INFO - PROCESS | 6747 | 15:09:54 INFO - PROCESS | 6747 | [#2] jquery.html Cycles:180 Average:29625.58 Median:2097.91 stddev:82651.18 (3939.7%) stddev-sans-first:82853.88 15:09:54 INFO - PROCESS | 6747 | Values: 387.3 399.5 410.3 422.7 430.5 15498.5 19871.0 20034.5 20044.7 20588.5 13618.7 13824.7 15740.9 20052.2 20713.2 4800.8 5315.8 5479.3 5525.3 5527.6 5956.4 6078.1 6079.8 6102.2 6103.2 5992.4 6089.8 6094.1 6553.8 6584.0 6547.3 6562.8 6581.6 6583.0 6587.2 5183.6 5429.9 5453.4 5492.1 5515.1 14870.6 15061.4 15100.8 15122.6 15269.2 2381.9 2702.5 2994.2 3009.2 3099.7 10860.2 11095.6 11128.4 11900.9 15312.2 1876.6 1927.5 1977.3 2006.1 2060.3 84624.6 85618.1 86328.0 86522.6 86655.0 11794.6 11862.1 12115.5 12142.2 12175.6 17137.1 17139.7 17149.5 17163.2 17200.9 7270.5 7285.8 7288.8 7959.1 8831.1 8465.4 8475.2 8518.6 8704.3 8755.6 5114.9 5153.2 5166.8 5189.0 5281.8 2017.4 2062.3 2076.7 2095.6 2100.2 925.5 960.1 1003.5 1013.8 1019.3 19639.9 19835.3 20004.5 20215.7 20394.5 1028.3 1030.2 1034.8 1052.1 1098.9 10358.6 11178.8 11202.2 11353.0 11393.8 471489.0 473383.0 491995.0 529228.0 531153.0 96927.0 98097.0 99067.5 99255.0 100327.5 996.5 1027.0 1035.2 1060.0 1067.1 17140.4 17438.5 17807.8 17843.3 18049.3 41298.8 41917.8 41932.4 42113.2 43235.8 58640.0 59011.4 59210.7 60564.0 60594.7 8567.0 8978.0 9192.1 9244.7 9441.2 12835.7 12859.7 12880.4 13404.7 13479.3 11396.0 11421.5 12055.9 12127.2 12379.5 11410.7 11465.0 11890.9 11991.6 12351.1 11527.4 11962.4 11974.9 12307.8 12371.5 8708.6 8949.6 9016.2 9302.5 9456.1 9183.9 11238.0 11582.4 11741.0 11807.9 15:09:54 INFO - PROCESS | 6747 | 15:09:54 INFO - PROCESS | 6747 | [#3] mootools.html Cycles:180 Average:5686.07 Median:2714.73 stddev:3196.15 (117.7%) stddev-sans-first:3188.99 15:09:54 INFO - PROCESS | 6747 | Values: 1414.6 1501.2 1534.7 1648.9 1789.8 7658.1 8004.2 8227.8 8253.1 8477.3 8290.6 8367.4 8369.2 8381.4 8382.0 2376.0 2392.3 2393.6 2394.5 2398.5 2372.0 2418.9 2447.9 2448.5 2448.7 2367.4 2405.1 2410.5 2413.4 2434.2 2325.6 2337.8 2361.8 2362.8 2362.8 2302.4 2376.3 2395.9 2397.9 2398.1 7649.7 7827.1 8302.0 8349.8 8408.8 4970.9 5120.7 5130.6 5133.3 5156.7 3407.3 3426.2 3502.2 3514.4 3522.6 1161.7 1166.7 1176.5 1198.1 1216.6 12044.1 12079.2 12079.9 12085.3 12085.5 4451.7 4706.5 4741.4 4835.0 4843.7 9630.4 9633.3 9634.2 9639.0 9669.1 5202.0 5217.3 5218.2 5234.2 5241.4 4787.6 4813.5 4833.7 5045.6 5103.1 3994.5 4074.5 4074.6 4144.8 4184.2 1356.2 1367.2 1397.1 1398.5 1400.3 942.5 953.7 956.1 956.8 982.1 5634.8 5742.9 5772.1 5788.1 5939.1 480.9 496.3 499.4 500.3 508.1 3894.9 3918.1 3920.2 3942.4 4029.4 10158.9 10813.2 10865.7 10872.2 10872.6 10457.5 10680.8 10694.4 10715.6 10718.2 8200.5 8315.8 8333.2 8335.1 8337.4 5521.9 5660.7 5666.5 5691.3 5801.2 9907.7 9910.1 9954.7 10019.4 10032.1 9949.0 10153.9 10173.3 10269.5 10273.2 7825.4 7874.8 7907.0 7919.7 7921.3 8283.7 8341.2 8468.2 8480.0 8491.7 7553.5 7614.0 7653.0 7673.8 7784.1 7652.1 7690.5 7694.3 7718.9 7814.0 6625.3 6734.8 6785.3 6791.1 6805.3 4693.3 4777.8 4850.4 4876.0 5040.8 4312.7 4933.2 4971.2 4992.5 5095.4 15:09:54 INFO - PROCESS | 6747 | 15:09:54 INFO - PROCESS | 6747 | [#4] prototype.html Cycles:180 Average:4709.47 Median:5369.84 stddev:1325.37 (24.7%) stddev-sans-first:1288.10 15:09:54 INFO - PROCESS | 6747 | Values: 352.2 353.3 356.2 363.1 372.8 5474.5 5489.1 5506.4 5524.8 5557.6 5385.9 5413.5 5449.3 5453.1 5468.4 4180.6 4269.9 4282.8 4295.7 4302.4 4254.9 4261.6 4266.8 4290.4 4303.1 4043.6 4259.6 4265.1 4293.0 4310.8 4150.4 4153.1 4222.1 4241.8 4260.8 3810.9 3814.4 3819.4 3819.6 3851.0 5041.0 5171.2 5188.0 5220.4 5235.4 4720.6 4842.4 4888.6 4893.2 4903.4 5629.7 5638.2 5644.6 5653.8 5667.2 4157.1 4250.3 4264.5 4264.8 4274.3 5772.5 5796.7 5810.2 5821.4 5823.2 4344.4 4356.7 4364.8 4371.5 4411.1 4178.7 4370.6 4391.7 4462.6 4465.0 4855.8 4856.6 4867.4 4891.0 4895.3 5657.6 5686.4 5692.4 5700.1 5725.4 1451.2 1469.7 1474.2 1478.3 1480.0 1027.8 1030.3 1036.8 1053.4 1059.2 5181.3 5282.9 5294.3 5298.3 5308.4 5493.3 5532.7 5558.4 5577.2 5591.4 5093.5 5269.5 5273.8 5383.6 5464.8 2940.2 2944.8 2959.9 2962.5 2980.0 5562.1 5636.3 5691.9 5730.9 5733.5 5627.6 5663.4 5698.0 5706.9 5721.9 5680.5 5683.6 5684.5 5703.3 5725.4 5313.2 5611.4 5630.9 5662.3 5669.7 5538.9 5557.4 5579.5 5581.4 5581.6 5388.8 5667.7 5675.1 5702.0 5718.3 4177.4 4197.4 4205.5 4210.6 4217.1 5576.4 5578.8 5584.6 5590.1 5636.4 5376.3 5470.6 5490.0 5497.7 5569.7 5456.5 5477.3 5502.9 5504.7 5512.3 5367.5 5372.2 5385.4 5429.7 5476.7 5235.4 5395.7 5443.9 5530.8 5549.9 5380.0 5382.9 5384.2 5392.3 5403.6 15:09:54 INFO - PROCESS | 6747 | 15:09:54 INFO - PROCESS | 6747 | [#5] yui.html Cycles:180 Average:16968.24 Median:44723.67 stddev:21002.26 (47.0%) stddev-sans-first:21025.97 15:09:54 INFO - PROCESS | 6747 | Values: 772.5 778.2 788.0 795.0 882.9 14459.9 15209.6 15344.6 16177.4 16377.4 13689.7 14502.1 14563.1 14655.1 14733.8 849.9 871.0 873.6 877.3 879.0 864.3 865.8 867.4 867.5 868.4 921.3 922.3 922.9 923.0 923.8 911.4 912.1 912.8 912.8 912.9 671.1 671.5 672.5 672.9 673.1 14699.5 15181.6 15257.7 15490.5 15692.5 14567.7 14747.2 15197.5 15252.8 15265.6 11563.4 11695.3 11971.2 12340.8 12776.4 3883.2 3890.8 3896.6 3916.9 4029.3 64537.4 65391.7 66907.3 67310.0 68602.0 11351.5 11425.0 11517.9 11550.2 11654.2 20094.3 20116.9 20199.0 20232.8 20620.6 8189.4 8377.9 8461.3 8638.0 8638.6 4944.7 4969.5 5025.4 5045.6 5088.8 3608.6 3738.0 3740.7 3741.3 3741.3 647.1 651.4 654.3 660.4 661.6 757.0 774.5 806.2 807.3 809.4 9806.8 10222.7 10293.7 10459.1 10815.1 730.5 774.8 780.3 782.6 796.3 4583.7 4586.2 4609.2 4655.0 4699.0 74996.6 75757.0 79558.6 83606.6 83720.0 46393.0 52717.0 54495.5 60629.7 70741.3 67797.3 67917.7 68291.7 68300.3 68705.0 9709.8 9729.6 9880.5 10002.7 10101.3 33436.2 37994.4 41072.2 45282.0 47361.8 42085.0 42381.6 44165.3 58801.4 61136.4 12922.2 13227.9 13374.7 13535.3 13565.9 14108.6 14566.2 14781.8 14832.6 15019.9 13922.5 13950.3 14174.4 14818.5 14974.0 13633.9 13644.6 13859.7 14290.3 14982.7 12762.9 13018.1 13142.2 13333.5 14078.4 10728.8 10791.6 10823.6 11558.5 11716.1 9888.8 10671.5 10925.0 11094.7 11246.5 15:09:54 INFO - PROCESS | 6747 | -------- Summary: end -------- 15:09:54 INFO - PROCESS | 6747 | 15:09:55 INFO - TEST-INFO | 6747: exit 0 15:09:55 INFO - TEST-OK | dromaeo_css | took 1115334ms 15:09:55 INFO - TEST-START | kraken 15:09:55 INFO - operating with platform_type : linux_ 15:09:55 INFO - Initialising browser for kraken test... 15:09:55 INFO - TEST-INFO | started process 7067 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK9oTOh/profile http://localhost:36434/getInfo.html) 15:09:59 INFO - PROCESS | 7067 | __metrics Screen width/height:1600/1200 15:09:59 INFO - PROCESS | 7067 | colorDepth:24 15:09:59 INFO - PROCESS | 7067 | Browser inner width/height: 1024/697 15:09:59 INFO - PROCESS | 7067 | __metrics 15:10:00 INFO - PROCESS | 7067 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:10:00 INFO - PROCESS | 7067 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:10:00 INFO - PROCESS | 7067 | console.error: PushService: 15:10:00 INFO - PROCESS | 7067 | stateChangeProcessEnqueue: Error transitioning state 15:10:00 INFO - PROCESS | 7067 | UnknownError 15:10:01 INFO - TEST-INFO | 7067: exit 0 15:10:01 INFO - Browser initialized. 15:10:01 INFO - Running cycle 1/1 for kraken test... 15:10:01 INFO - TEST-INFO | started process 7160 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK9oTOh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:10:13 INFO - PROCESS | 7160 | RSS: Main: 148000768 15:10:13 INFO - PROCESS | 7160 | 15:10:15 INFO - PROCESS | 7160 | Cycle 1(1): loaded http://localhost:36434/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36434/tests/kraken/driver.html?testName=audio-beat-detection) 15:10:16 INFO - PROCESS | 7160 | RSS: Main: 189460480 15:10:16 INFO - PROCESS | 7160 | 15:10:19 INFO - PROCESS | 7160 | Cycle 1(1): loaded http://localhost:36434/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36434/tests/kraken/driver.html?testName=audio-dft) 15:10:19 INFO - PROCESS | 7160 | RSS: Main: 178835456 15:10:19 INFO - PROCESS | 7160 | 15:10:22 INFO - PROCESS | 7160 | Cycle 1(1): loaded http://localhost:36434/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36434/tests/kraken/driver.html?testName=audio-fft) 15:10:23 INFO - PROCESS | 7160 | RSS: Main: 270180352 15:10:23 INFO - PROCESS | 7160 | 15:10:25 INFO - PROCESS | 7160 | Cycle 1(1): loaded http://localhost:36434/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36434/tests/kraken/driver.html?testName=audio-oscillator) 15:10:25 INFO - PROCESS | 7160 | RSS: Main: 176361472 15:10:25 INFO - PROCESS | 7160 | 15:10:27 INFO - PROCESS | 7160 | Cycle 1(1): loaded http://localhost:36434/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36434/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:10:28 INFO - PROCESS | 7160 | RSS: Main: 179339264 15:10:28 INFO - PROCESS | 7160 | 15:10:31 INFO - PROCESS | 7160 | Cycle 1(1): loaded http://localhost:36434/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36434/tests/kraken/driver.html?testName=imaging-darkroom) 15:10:31 INFO - PROCESS | 7160 | RSS: Main: 217427968 15:10:31 INFO - PROCESS | 7160 | 15:10:35 INFO - PROCESS | 7160 | Cycle 1(1): loaded http://localhost:36434/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36434/tests/kraken/driver.html?testName=imaging-desaturate) 15:10:35 INFO - PROCESS | 7160 | RSS: Main: 216494080 15:10:35 INFO - PROCESS | 7160 | 15:10:38 INFO - PROCESS | 7160 | Cycle 1(1): loaded http://localhost:36434/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36434/tests/kraken/driver.html?testName=json-parse-financial) 15:10:39 INFO - PROCESS | 7160 | RSS: Main: 214900736 15:10:39 INFO - PROCESS | 7160 | 15:10:40 INFO - PROCESS | 7160 | Cycle 1(1): loaded http://localhost:36434/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36434/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:10:41 INFO - PROCESS | 7160 | RSS: Main: 177025024 15:10:41 INFO - PROCESS | 7160 | 15:10:42 INFO - PROCESS | 7160 | Cycle 1(1): loaded http://localhost:36434/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36434/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:10:43 INFO - PROCESS | 7160 | RSS: Main: 184127488 15:10:43 INFO - PROCESS | 7160 | 15:10:45 INFO - PROCESS | 7160 | Cycle 1(1): loaded http://localhost:36434/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36434/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:10:46 INFO - PROCESS | 7160 | RSS: Main: 190238720 15:10:46 INFO - PROCESS | 7160 | 15:10:48 INFO - PROCESS | 7160 | Cycle 1(1): loaded http://localhost:36434/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36434/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:10:49 INFO - PROCESS | 7160 | RSS: Main: 199618560 15:10:49 INFO - PROCESS | 7160 | 15:10:52 INFO - PROCESS | 7160 | Cycle 1(1): loaded http://localhost:36434/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36434/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:10:52 INFO - PROCESS | 7160 | RSS: Main: 195129344 15:10:52 INFO - PROCESS | 7160 | 15:10:54 INFO - PROCESS | 7160 | Cycle 1(1): loaded http://localhost:36434/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36434/tests/kraken/driver.html?testName=ai-astar) 15:10:54 INFO - PROCESS | 7160 | RSS: Main: 246857728 15:10:54 INFO - PROCESS | 7160 | 15:10:54 INFO - PROCESS | 7160 | __start_tp_report 15:10:54 INFO - PROCESS | 7160 | _x_x_mozilla_page_load 15:10:54 INFO - PROCESS | 7160 | _x_x_mozilla_page_load_details 15:10:54 INFO - PROCESS | 7160 | |i|pagename|runs| 15:10:54 INFO - PROCESS | 7160 | |0;ai-astar;102;112;112;111;111;111;111;111;111;111 15:10:54 INFO - PROCESS | 7160 | |1;audio-beat-detection;144;117;117;156;120;119;117;116;145;124 15:10:54 INFO - PROCESS | 7160 | |2;audio-dft;161;161;160;161;161;161;163;163;163;162 15:10:54 INFO - PROCESS | 7160 | |3;audio-fft;74;77;75;121;76;76;76;74;95;75 15:10:54 INFO - PROCESS | 7160 | |4;audio-oscillator;82;81;111;80;82;81;99;82;81;117 15:10:54 INFO - PROCESS | 7160 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 15:10:54 INFO - PROCESS | 7160 | |6;imaging-darkroom;155;149;151;149;156;161;153;149;151;160 15:10:54 INFO - PROCESS | 7160 | |7;imaging-desaturate;84;85;84;84;85;85;85;85;85;84 15:10:54 INFO - PROCESS | 7160 | |8;json-parse-financial;52;52;53;53;52;53;52;53;51;54 15:10:54 INFO - PROCESS | 7160 | |9;json-stringify-tinderbox;59;59;59;60;60;59;58;59;59;59 15:10:54 INFO - PROCESS | 7160 | |10;stanford-crypto-aes;76;76;78;80;76;77;74;82;74;76 15:10:54 INFO - PROCESS | 7160 | |11;stanford-crypto-ccm;142;135;121;120;119;122;121;123;175;123 15:10:54 INFO - PROCESS | 7160 | |12;stanford-crypto-pbkdf2;150;154;152;152;157;154;157;153;152;153 15:10:54 INFO - PROCESS | 7160 | |13;stanford-crypto-sha256-iterative;64;63;62;61;63;61;63;62;60;63 15:10:54 INFO - PROCESS | 7160 | __end_tp_report 15:10:54 INFO - PROCESS | 7160 | __start_cc_report 15:10:54 INFO - PROCESS | 7160 | _x_x_mozilla_cycle_collect,1640 15:10:54 INFO - PROCESS | 7160 | __end_cc_report 15:10:54 INFO - PROCESS | 7160 | __startTimestamp1482275454533__endTimestamp 15:10:54 INFO - PROCESS | 7160 | 15:10:54 INFO - PROCESS | 7160 | ------- Summary: start ------- 15:10:54 INFO - PROCESS | 7160 | Number of tests: 14 15:10:54 INFO - PROCESS | 7160 | 15:10:54 INFO - PROCESS | 7160 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.00 stddev:2.95 (2.7%) stddev-sans-first:0.44 15:10:54 INFO - PROCESS | 7160 | Values: 102.0 112.0 112.0 111.0 111.0 111.0 111.0 111.0 111.0 111.0 15:10:54 INFO - PROCESS | 7160 | 15:10:54 INFO - PROCESS | 7160 | [#1] audio-beat-detection Cycles:10 Average:127.50 Median:122.00 stddev:14.89 (12.2%) stddev-sans-first:14.54 15:10:54 INFO - PROCESS | 7160 | Values: 144.0 117.0 117.0 156.0 120.0 119.0 117.0 116.0 145.0 124.0 15:10:54 INFO - PROCESS | 7160 | 15:10:54 INFO - PROCESS | 7160 | [#2] audio-dft Cycles:10 Average:161.60 Median:161.50 stddev:1.07 (0.7%) stddev-sans-first:1.12 15:10:54 INFO - PROCESS | 7160 | Values: 161.0 161.0 160.0 161.0 161.0 161.0 163.0 163.0 163.0 162.0 15:10:54 INFO - PROCESS | 7160 | 15:10:54 INFO - PROCESS | 7160 | [#3] audio-fft Cycles:10 Average:81.90 Median:76.00 stddev:15.09 (19.9%) stddev-sans-first:15.73 15:10:54 INFO - PROCESS | 7160 | Values: 74.0 77.0 75.0 121.0 76.0 76.0 76.0 74.0 95.0 75.0 15:10:54 INFO - PROCESS | 7160 | 15:10:54 INFO - PROCESS | 7160 | [#4] audio-oscillator Cycles:10 Average:89.60 Median:81.50 stddev:14.08 (17.3%) stddev-sans-first:14.66 15:10:54 INFO - PROCESS | 7160 | Values: 82.0 81.0 111.0 80.0 82.0 81.0 99.0 82.0 81.0 117.0 15:10:54 INFO - PROCESS | 7160 | 15:10:54 INFO - PROCESS | 7160 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 15:10:54 INFO - PROCESS | 7160 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 15:10:54 INFO - PROCESS | 7160 | 15:10:54 INFO - PROCESS | 7160 | [#6] imaging-darkroom Cycles:10 Average:153.40 Median:154.00 stddev:4.48 (2.9%) stddev-sans-first:4.71 15:10:54 INFO - PROCESS | 7160 | Values: 155.0 149.0 151.0 149.0 156.0 161.0 153.0 149.0 151.0 160.0 15:10:54 INFO - PROCESS | 7160 | 15:10:54 INFO - PROCESS | 7160 | [#7] imaging-desaturate Cycles:10 Average:84.60 Median:85.00 stddev:0.52 (0.6%) stddev-sans-first:0.50 15:10:54 INFO - PROCESS | 7160 | Values: 84.0 85.0 84.0 84.0 85.0 85.0 85.0 85.0 85.0 84.0 15:10:54 INFO - PROCESS | 7160 | 15:10:54 INFO - PROCESS | 7160 | [#8] json-parse-financial Cycles:10 Average:52.50 Median:53.00 stddev:0.85 (1.6%) stddev-sans-first:0.88 15:10:54 INFO - PROCESS | 7160 | Values: 52.0 52.0 53.0 53.0 52.0 53.0 52.0 53.0 51.0 54.0 15:10:54 INFO - PROCESS | 7160 | 15:10:54 INFO - PROCESS | 7160 | [#9] json-stringify-tinderbox Cycles:10 Average:59.10 Median:59.00 stddev:0.57 (1.0%) stddev-sans-first:0.60 15:10:54 INFO - PROCESS | 7160 | Values: 59.0 59.0 59.0 60.0 60.0 59.0 58.0 59.0 59.0 59.0 15:10:54 INFO - PROCESS | 7160 | 15:10:54 INFO - PROCESS | 7160 | [#10] stanford-crypto-aes Cycles:10 Average:76.90 Median:76.50 stddev:2.51 (3.3%) stddev-sans-first:2.65 15:10:54 INFO - PROCESS | 7160 | Values: 76.0 76.0 78.0 80.0 76.0 77.0 74.0 82.0 74.0 76.0 15:10:54 INFO - PROCESS | 7160 | 15:10:54 INFO - PROCESS | 7160 | [#11] stanford-crypto-ccm Cycles:10 Average:130.10 Median:123.00 stddev:17.44 (14.2%) stddev-sans-first:17.96 15:10:54 INFO - PROCESS | 7160 | Values: 142.0 135.0 121.0 120.0 119.0 122.0 121.0 123.0 175.0 123.0 15:10:54 INFO - PROCESS | 7160 | 15:10:54 INFO - PROCESS | 7160 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.40 Median:153.50 stddev:2.22 (1.4%) stddev-sans-first:1.99 15:10:54 INFO - PROCESS | 7160 | Values: 150.0 154.0 152.0 152.0 157.0 154.0 157.0 153.0 152.0 153.0 15:10:54 INFO - PROCESS | 7160 | 15:10:54 INFO - PROCESS | 7160 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.20 Median:63.00 stddev:1.23 (2.0%) stddev-sans-first:1.12 15:10:54 INFO - PROCESS | 7160 | Values: 64.0 63.0 62.0 61.0 63.0 61.0 63.0 62.0 60.0 63.0 15:10:54 INFO - PROCESS | 7160 | -------- Summary: end -------- 15:10:54 INFO - PROCESS | 7160 | 15:10:55 INFO - TEST-INFO | 7160: exit 0 15:10:55 INFO - TEST-OK | kraken | took 59937ms 15:10:55 INFO - SUITE-END | took 1175s 15:10:55 INFO - Completed test suite (00:19:35) 15:10:55 INFO - javascript benchmark 15:10:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3156.2267244525087, 3200.103970888152, 3210.406074876148, 3224.7097761201485, 3233.175540237239, 5437.592180586457, 5460.808871689486, 5515.779368825252, 5542.196381524676, 5566.8329950101515, 5578.86052848679, 5593.8601534961645, 5595.21666966625, 5604.822987172688, 5608.0, 5054.0, 5082.542571168594, 5107.310513080743, 5114.820981265657, 5116.769745361467, 4983.252512123175, 5135.666181698196, 5155.639105262633, 5172.379314482268, 5186.455422180673, 4982.028504441635, 4996.950030499703, 5016.44819069902, 5027.698338099707, 5055.443901170868, 5099.311592934962, 5113.769880355393, 5135.281060651511, 5178.559822415099, 5183.300254465675, 5005.849824505271, 5081.2632168335385, 5123.641345105844, 5140.3060586820675, 5163.1480805667015, 5369.060414427459, 5419.376771671269, 5434.239206511092, 5497.697626630534, 5523.530499907512, 5859.8535036624, 5860.648361098348, 5878.118282257653, 5967.075103358986, 5970.0, 6005.1892994445625, 6007.15899774032, 6015.0, 6017.909731354033, 6021.066734656135, 5413.296271484721, 5441.102218134003, 5509.201165830932, 5565.276514053228, 5571.804986825523, 6081.787137450168, 6102.084687296941, 6114.052321890114, 6119.9902016167725, 6122.448979591858, 5863.208466857005, 5878.970605146947, 5885.646861188342, 5887.0580707086665, 5897.262842144732, 5814.04068328721, 5868.970655146697, 5929.199558059607, 5970.194023806817, 5982.850428739229, 5974.492168165754, 5977.372375900555, 5980.983232850426, 5997.370276121032, 6036.879262414727, 5979.790707325223, 6016.608920420159, 6027.638341699512, 6030.18592490017, 6030.396960303934, 4550.362949187116, 4565.931511027337, 4608.516105808909, 4613.884652883705, 4678.532146785295, 4092.7748973806133, 4129.566395528426, 4140.565240649748, 4155.231282212801, 4173.937390939138, 5631.2960879890015, 5637.633553819071, 5647.068233741386, 5648.096304591246, 5651.095824668033, 5779.971100144472, 5852.853678658068, 5886.58793884424, 5983.521318294526, 5985.042393217152, 5551.056320425457, 5596.804111856066, 5600.383957764642, 5626.212330273765, 5626.831195064155, 5146.691198528026, 5147.6396652234735, 5153.3558305211845, 5155.664881782672, 5190.480951904779, 5840.328362238227, 5953.196318496947, 6095.05526643371, 6095.390460953958, 6105.664188469588, 5895.115732639967, 5913.0, 5950.19672344228, 6030.366811484906, 6059.969700151471, 6103.389661033861, 6130.325664177026, 6130.816075517741, 6135.417135372132, 6135.7238924249405, 5676.120201368794, 5893.5874488785375, 5910.615809972338, 5913.34953155144, 5913.526917846648, 5752.68360240174, 5871.7651293947765, 5877.089051197071, 5918.496927761016, 5958.553108516792, 5765.279340082489, 5806.564507662027, 5811.738471768696, 5815.011448053757, 5821.825345239649, 5772.307323121252, 5781.653100813965, 5782.45066718661, 5788.479036886701, 5790.247267855152, 5567.4432556744005, 5582.860428489158, 5638.126090455986, 5742.109972954198, 5747.9137812932, 5874.236349274567, 5877.706114694333, 5882.117682347682, 5898.587098903035, 5899.587028907935, 5526.171074338881, 5576.079946808731, 5720.199172115824, 5721.399253078534, 5730.0], "value": 5482.171668781414, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.6183557016799, 602.6354055796243, 608.115192395065, 641.9069234960928, 655.2497390487895, 33625.1593710157, 43378.56621433785, 43651.56348436515, 43832.34251486226, 43848.56151438485, 44274.0, 44526.55473445264, 44639.0, 44644.0, 44646.77676611621, 8293.0, 8887.111288871125, 9025.909740902605, 9030.954845225764, 9037.95481022594, 8273.296769774577, 10515.421651809147, 10745.78508429831, 10799.352038877652, 11092.722681932975, 10897.564097436092, 10965.067969222626, 10966.506507207196, 10970.835437468444, 10974.396408197546, 10828.296160749565, 10919.454027298603, 10921.890781092166, 10926.453677316102, 10965.671029869116, 10814.405207713573, 10861.511231994578, 10879.401632910187, 10886.40124793136, 10890.183236257233, 42520.66136362499, 42866.57133428657, 42870.0, 42887.35668964968, 42961.14077718459, 3762.962370376316, 4025.677945764332, 4297.290946993742, 4353.390525326457, 4410.558944105596, 31985.52021719676, 32426.67573324284, 32704.182395440068, 32821.507677384856, 33259.6674033259, 3638.399664055428, 3650.0, 3685.7972811495356, 3731.2350968051483, 3799.1072098056934, 359444.0, 359616.0, 360009.0, 360174.0, 360370.0, 38115.61884381176, 52020.0, 52101.7394913023, 52278.738606306724, 52312.21531677028, 39359.60640393559, 41573.0, 41603.0, 41603.7919810399, 41619.583804162176, 15135.56212159843, 15150.848491515164, 15159.166245856362, 15160.545183644508, 15168.848311516964, 12497.312647804458, 13012.869871301165, 13205.801912971314, 14050.718985620231, 14197.0, 9503.57233924475, 9672.0, 9697.806043879084, 9745.220382369393, 9752.0, 3516.4197907345515, 3578.499010138583, 3618.3125206210734, 3638.6361363863402, 3667.64297210034, 1034.9741256468499, 1070.8019016481976, 1114.3648120571197, 1128.2384390536356, 1146.3179408252076, 31692.937910825538, 33500.49749253763, 33885.32229355448, 34115.82942085274, 34420.0, 1090.4493230918495, 1101.581399068349, 1135.103268417957, 1142.6686260984388, 1150.6605551362368, 16275.186240687919, 17315.56711082233, 17394.826051739572, 17441.912790435967, 17542.122893855256, 568353.0, 570695.0, 571905.0, 573867.0, 577125.0, 59449.40550594525, 59516.0, 59563.70218148968, 60020.399796002355, 60107.0, 1293.502001729341, 1350.1966330033615, 1416.9433222670978, 1448.9058211216238, 1449.463698431587, 30897.382052358378, 33564.832175838965, 34069.48895766516, 34575.82712086423, 34852.128696782784, 51000.0, 57089.42910571007, 58817.70591147188, 58846.41153588409, 64823.351766481734, 410861.0, 414487.0, 414836.0, 416316.0, 416814.0, 30266.69733302727, 30401.543976840807, 30404.847975759978, 32810.0, 44297.0, 50398.49601503938, 50511.49488505068, 50738.98522029465, 50800.0, 52031.73984130055, 41744.1651166981, 42366.152676946906, 42395.09222084952, 43800.342994854465, 44236.0, 42027.57972420237, 42318.57681423269, 42342.57657423509, 42394.78802605967, 44290.11419771522, 41132.0, 41599.7920010398, 41697.583024170584, 47300.29049564328, 48067.0, 43943.198804185355, 45505.77247113743, 45698.31452528148, 46119.3082103762, 47066.52933470622, 36240.45639315465, 36893.631063690096, 37020.814895925345, 37109.443358349105, 37181.81409092937], "value": 20189.282237686308, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.33765261403, 399.5105995155934, 410.3147743268741, 422.66820545871485, 430.4576233945228, 15498.457553985612, 19871.0, 20034.49913752157, 20044.69932951007, 20588.48528786781, 13618.659533511667, 13824.654383640414, 15740.898137130405, 20052.1979120835, 20713.171473141058, 4800.783964721596, 5315.760790764405, 5479.315085614298, 5525.281713377255, 5527.585431092664, 5956.434138756811, 6078.118672792442, 6079.756809727605, 6102.206713127287, 6103.23709536308, 5992.430719081702, 6089.78685745999, 6094.146819445281, 6553.836154096162, 6583.9670801645925, 6547.3125321841235, 6562.803115906483, 6581.605103693793, 6582.967085164568, 6587.242467116295, 5183.585313174937, 5429.914017196537, 5453.4273901240595, 5492.121260598325, 5515.09001014832, 14870.628234294121, 15061.397544098223, 15100.773488397683, 15122.621934451618, 15269.160196189205, 2381.9047238110456, 2702.50003749307, 2994.191568276575, 3009.1574359179244, 3099.736522395599, 10860.185486088574, 11095.611653592085, 11128.443577821077, 11900.880991190064, 15312.157831319273, 1876.6246750649789, 1927.4603111128906, 1977.2881762565464, 2006.1373609347975, 2060.2789023841688, 84624.57687711583, 85618.14381856164, 86328.0, 86522.56738716329, 86655.0, 11794.646160615195, 11862.110341724405, 12115.515379384726, 12142.210756300812, 12175.634730958085, 17137.05746183972, 17139.657206855794, 17149.485515434557, 17163.227654755567, 17200.881942673685, 7270.527415717961, 7285.817854553678, 7288.8177795554475, 7959.084705258853, 8831.116888311246, 8465.449745766506, 8475.194856488624, 8518.57407129641, 8704.303655707528, 8755.605997730117, 5114.897702045938, 5153.201253805666, 5166.81916132941, 5189.040027594907, 5281.788728450819, 2017.3544465770813, 2062.3400511836066, 2076.6988786625857, 2095.5808838232415, 2100.2334148035857, 925.4632313258294, 960.0687333286701, 1003.508280942333, 1013.7719013222113, 1019.3425240719695, 19639.901800490905, 19835.305764298468, 20004.49988750293, 20215.696764548542, 20394.49013774638, 1028.3058935218698, 1030.217035053365, 1034.8033873564, 1052.137247457093, 1098.8846171152074, 10358.637447689294, 11178.826223246604, 11202.159838012181, 11353.0, 11393.772124557463, 471489.0, 473383.0, 491995.0, 529228.0, 531153.0, 96927.0, 98097.0, 99067.50466247767, 99255.0, 100327.49836250771, 996.531630133836, 1026.97432564185, 1035.233926894093, 1060.0035966191908, 1067.1196263082988, 17140.40008599693, 17438.47684569465, 17807.821921781135, 17843.286268549113, 18049.278028879224, 41298.79350603228, 41917.79041104775, 41932.37101443542, 42113.15773684448, 43235.783821080695, 58640.0, 59011.40988590231, 59210.70394647999, 60564.0, 60594.69702651635, 8567.048966691305, 8978.0, 9192.080791921022, 9244.676436324697, 9441.197498212729, 12835.679108022374, 12859.678508037, 12880.35598220104, 13404.731905361643, 13479.258640774851, 11396.0, 11421.543138274375, 12055.879441205476, 12127.211731237441, 12379.504819807107, 11410.657680269605, 11465.0, 11890.881091189323, 11991.561012678534, 12351.073669475005, 11527.423628818693, 11962.401879906143, 11974.880251197377, 12307.815382769086, 12371.505139794308, 8708.60811263482, 8949.552522373986, 9016.18854303116, 9302.534873256174, 9456.101670341306, 9183.908160918305, 11238.0, 11582.420878956187, 11741.0, 11807.940960295144], "value": 9447.870734973347, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1414.5614859393581, 1501.1668523969192, 1534.6547026918943, 1648.8705236912708, 1789.8210178982094, 7658.119316278629, 8004.159563245863, 8227.753167404973, 8253.133420990793, 8477.279431248337, 8290.58547072647, 8367.414281000332, 8369.246767790897, 8381.371397145209, 8381.958090209555, 2376.0495801679294, 2392.3301475586863, 2393.617021276596, 2394.4971555973266, 2398.5322862041908, 2371.988140059306, 2418.9274321770376, 2447.8898449569724, 2448.52253810507, 2448.7306396296394, 2367.4199821043867, 2405.1461731085474, 2410.4937963027696, 2413.372523143986, 2434.221049264236, 2325.616273314901, 2337.836351455399, 2361.822863285252, 2362.799162071226, 2362.799162071226, 2302.3783578433895, 2376.263358358914, 2395.9401014974765, 2397.880105994693, 2398.07674045492, 7649.655765490566, 7827.099883513412, 8302.0, 8349.791255218608, 8408.789780255482, 4970.87572810679, 5120.718360490171, 5130.563902068328, 5133.30700355451, 5156.74216289184, 3407.30150319184, 3426.1605906552804, 3502.1594817243677, 3514.3674138655033, 3522.5772907251294, 1161.7211869151427, 1166.7374840660868, 1176.5176277726177, 1198.1373411143963, 1216.6471723200261, 12044.096692748079, 12079.154459187861, 12079.93960030203, 12085.274883507105, 12085.45615447307, 4451.732896026184, 4706.458757242961, 4741.383620129361, 4834.95165048352, 4843.709377437365, 9630.374025688308, 9633.277504187214, 9634.229261659051, 9638.95180524107, 9669.129778319984, 5202.0, 5217.34783152106, 5218.243354713545, 5234.18870075139, 5241.42344342122, 4787.640926930494, 4813.470518242991, 4833.734144622009, 5045.621578381562, 5103.106956282636, 3994.4807175067635, 4074.5314288856566, 4074.5517993020744, 4144.772037537964, 4184.205001049791, 1356.1659579358623, 1367.234348764695, 1397.0569865340854, 1398.5314919501877, 1400.2788563889605, 942.528735632184, 953.7043516509765, 956.1108169402384, 956.7751578379075, 982.1160955140431, 5634.774609015675, 5742.885142297131, 5772.076467765138, 5788.131780232999, 5939.13882487037, 480.89660722944734, 496.3026947139275, 499.4106953794485, 500.3445486412811, 508.13870489520644, 3894.941575876364, 3918.1184233547224, 3920.2159568086495, 3942.4283478895973, 4029.435878976946, 10158.949205253926, 10813.243072984973, 10865.728356790985, 10872.238943273895, 10872.61945831892, 10457.477126143815, 10680.78638427227, 10694.35833849956, 10715.571377144826, 10718.249722519504, 8200.466969646954, 8315.83368332642, 8333.166683331618, 8335.083140854502, 8337.374696897758, 5521.861953451196, 5660.660360378391, 5666.546676265806, 5691.345495268097, 5801.1878337033695, 9907.653232136841, 9910.058544438267, 9954.701358959242, 10019.398836069859, 10032.097111259729, 9949.0, 10153.949230253802, 10173.338732982333, 10269.537870795682, 10273.178145748172, 7825.373970082266, 7874.803129921798, 7906.960465197637, 7919.722809701633, 7921.32668723165, 8283.710070147516, 8341.165883411853, 8468.153184681483, 8479.95760021196, 8491.702790402307, 7553.546787192786, 7614.0, 7652.961735191288, 7673.808154796175, 7784.065912090586, 7652.081750190013, 7690.461667683208, 7694.269044440769, 7718.884216736866, 7814.0, 6625.304343044104, 6734.764283250062, 6785.321467853175, 6791.117154769849, 6805.251422343439, 4693.272542755878, 4777.761111944319, 4850.417949846041, 4875.976045030583, 5040.773165207501, 4312.676549258756, 4933.1613625683, 4971.229459433794, 4992.525710057539, 5095.414027386898], "value": 4530.695635471073, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.18117875938435, 353.318096074576, 356.2038843185481, 363.1321142469497, 372.75584492157645, 5474.534664553513, 5489.149181876811, 5506.366767821702, 5524.806631767889, 5557.5831812614115, 5385.946140538594, 5413.458654134584, 5449.264349312842, 5453.127499600065, 5468.3711373192, 4180.644645205161, 4269.893252668677, 4282.807273672676, 4295.656347492193, 4302.354646802989, 4254.872353829374, 4261.595148460891, 4266.765327906964, 4290.356446533014, 4303.053328267776, 4043.615856493643, 4259.5740425957465, 4265.104328091104, 4292.969687275047, 4310.762908040057, 4150.418941348214, 4153.107081977374, 4222.134462435193, 4241.809118589671, 4260.829566817323, 3810.942835857464, 3814.408766641175, 3819.4461803038403, 3819.598942111094, 3850.998740327507, 5040.974795126001, 5171.22431635254, 5187.974060129675, 5220.425753167148, 5235.397929238148, 4720.622350211975, 4842.394700662418, 4888.560029597318, 4893.168161412568, 4903.411590609114, 5629.662220266797, 5638.238837756891, 5644.6330988485615, 5653.830385088454, 5667.206591077253, 4157.147784704129, 4250.277452832995, 4264.530901600821, 4264.786760661955, 4274.29474136767, 5772.480476757112, 5796.739146738365, 5810.1865738796605, 5821.388754180793, 5823.184754134425, 4344.391785150082, 4356.6950313477755, 4364.8214981955325, 4371.497277813029, 4411.117776444724, 4178.7283826551175, 4370.628496577763, 4391.738254798781, 4462.620677242406, 4465.013069184181, 4855.830045948375, 4856.587190088882, 4867.367242258484, 4891.0, 4895.33912921751, 5657.632253903483, 5686.431356864363, 5692.402297758758, 5700.116481945305, 5725.370209276976, 1451.2163431746949, 1469.7427950108902, 1474.1965628732366, 1478.3125846481437, 1480.0, 1027.814993301213, 1030.283952652899, 1036.7770929250248, 1053.3837704942541, 1059.232056758859, 5181.26427646735, 5282.947170528322, 5294.311739473921, 5298.311219541435, 5308.416074231832, 5493.340799104053, 5532.7039278698885, 5558.388577256498, 5577.2191893135, 5591.412901645269, 5093.541581257705, 5269.499397557226, 5273.785010295685, 5383.627175070332, 5464.781408743605, 2940.2355387599378, 2944.7926350196317, 2959.896403625906, 2962.511185654343, 2979.9851000744857, 5562.137868630369, 5636.323641163087, 5691.886162276731, 5730.914036289459, 5733.483986441241, 5627.606067575231, 5663.40373862592, 5697.971510142423, 5706.889745088936, 5721.8569535761935, 5680.517156041783, 5683.630564013326, 5684.516816070681, 5703.258576385127, 5725.4274572543245, 5313.229581710708, 5611.38274789781, 5630.901974115009, 5662.320521537442, 5669.659820410789, 5538.944610553843, 5557.416471270459, 5579.525740312119, 5581.376752926119, 5581.553475722014, 5388.838334849961, 5667.716614169358, 5675.091985282335, 5701.971490142523, 5718.285214348207, 4177.394277829637, 4197.412362269224, 4205.537390886939, 4210.578942105765, 4217.051163488313, 5576.358718747396, 5578.772670012753, 5584.609077364546, 5590.133529302964, 5636.436356364331, 5376.274202982704, 5470.562355011669, 5489.972550137224, 5497.725113744217, 5569.749361278671, 5456.48163424474, 5477.260569823182, 5502.862428439321, 5504.724763761716, 5512.318742783329, 5367.463253674601, 5372.221027951004, 5385.441915090458, 5429.728513574384, 5476.726163691879, 5235.3717553893775, 5395.678058875444, 5443.918341224964, 5530.834074977596, 5549.889002219852, 5380.0, 5382.919256211082, 5384.19237114436, 5392.272043274108, 5403.567714582902], "value": 4297.561625575363, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [772.4669977715376, 778.2101167315175, 787.9881801772971, 795.041974420823, 882.9249513791327, 14459.855401445982, 15209.619759506004, 15344.61638459039, 16177.35290588375, 16377.42679006235, 13689.65775855604, 14502.129872207675, 14563.126212427236, 14655.120692758415, 14733.778993315109, 849.8682704180862, 871.0070519607652, 873.5894129759004, 877.32007694037, 879.0462348352014, 864.2826454043161, 865.7965378136133, 867.3928250224836, 867.4751775176022, 868.4008034456205, 921.2952091649893, 922.2667978956712, 922.916937475627, 923.0400383601046, 923.8383282925495, 911.3620465674021, 912.0788004115824, 912.7991841794794, 912.8402529557368, 912.8904531456201, 671.1208317104608, 671.516508114157, 672.5191488085993, 672.9158855143107, 673.1148539670318, 14699.485518006819, 15181.620459488491, 15257.694846103015, 15490.457833975757, 15692.529224123295, 14567.708645827024, 14747.188904610242, 15197.544073677696, 15252.847471525365, 15265.61835954099, 11563.421828908606, 11695.298282103102, 11971.162018658697, 12340.753184936251, 12776.42506087219, 3883.165119499321, 3890.8443662253476, 3896.649301562873, 3916.8824935251987, 4029.315016447211, 64537.354626453605, 65391.67304163496, 66907.33092669108, 67310.0, 68602.0, 11351.545938162546, 11425.021741831284, 11517.942410288062, 11550.249233799776, 11654.184207105422, 20094.296699615443, 20116.89941550283, 20199.0, 20232.797672023386, 20620.58758824845, 8189.426740128134, 8377.874331885027, 8461.323094152453, 8638.0, 8638.568071596395, 4944.728039957837, 4969.478204788517, 5025.39695236574, 5045.596352291881, 5088.796448142033, 3608.6030536640947, 3737.972057684104, 3740.663340299386, 3741.251749650081, 3741.270452261783, 647.1005302629349, 651.3519048546726, 654.2737561306946, 660.3561527510639, 661.6493258572964, 756.9545827250382, 774.5043172369687, 806.2179685704857, 807.2774866494454, 809.3767798794895, 9806.803863922823, 10222.744431389276, 10293.74265643365, 10459.110975567162, 10815.134789216843, 730.4850080693204, 774.7830607429929, 780.286038274972, 782.5578548120294, 796.2873228460611, 4583.72497650142, 4586.151561960981, 4609.193391156534, 4654.953450465519, 4698.976505117453, 74996.62501687456, 75757.0, 79558.60220698976, 83606.581967091, 83720.0, 46393.0, 52717.0, 54495.45504544904, 60629.69685151634, 70741.2925870745, 67797.3220267791, 67917.66041169762, 68291.65854170697, 68300.3169968294, 68705.0, 9709.805803884024, 9729.648991784914, 9880.45657488845, 10002.699919002442, 10101.292909496266, 33436.164095897795, 37994.43008354821, 41072.1785564293, 45282.0, 47361.7631911852, 42085.0, 42381.576184239, 44165.33751993787, 58801.4119858796, 61136.38863611307, 12922.160059596095, 13227.867721322664, 13374.665633359244, 13535.323233838466, 13565.864341356855, 14108.645448333342, 14566.198859062853, 14781.778273325694, 14832.629184270048, 15019.924900375428, 13922.51271205503, 13950.302484875512, 14174.362153703314, 14818.481353152589, 14974.0, 13633.863661363655, 13644.590662280147, 13859.653508662364, 14290.285485725464, 14982.700345993237, 12762.936185319015, 13018.088733788543, 13142.211467311992, 13333.466661333438, 14078.436862525385, 10728.785424291314, 10791.56833726642, 10823.621173258898, 11558.49230175752, 11716.121290903387, 9888.802223955337, 10671.519781609692, 10925.0, 11094.722631934266, 11246.493907774005], "value": 7349.839538740492, "unit": "score"}], "name": "dromaeo_css", "value": 7286.5099772327, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 112.0, 111.0, 111.0, 111.0, 111.0, 111.0, 111.0, 111.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 117.0, 117.0, 156.0, 120.0, 119.0, 117.0, 116.0, 145.0, 124.0], "value": 127.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 161.0, 161.0, 161.0, 163.0, 163.0, 163.0, 162.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 75.0, 121.0, 76.0, 76.0, 76.0, 74.0, 95.0, 75.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 111.0, 80.0, 82.0, 81.0, 99.0, 82.0, 81.0, 117.0], "value": 89.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 149.0, 151.0, 149.0, 156.0, 161.0, 153.0, 149.0, 151.0, 160.0], "value": 153.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 84.0, 84.0, 85.0, 85.0, 85.0, 85.0, 85.0, 84.0], "value": 84.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 53.0, 53.0, 52.0, 53.0, 52.0, 53.0, 51.0, 54.0], "value": 52.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 60.0, 60.0, 59.0, 58.0, 59.0, 59.0, 59.0], "value": 59.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 78.0, 80.0, 76.0, 77.0, 74.0, 82.0, 74.0, 76.0], "value": 76.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 135.0, 121.0, 120.0, 119.0, 122.0, 121.0, 123.0, 175.0, 123.0], "value": 130.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 154.0, 152.0, 152.0, 157.0, 154.0, 157.0, 153.0, 152.0, 153.0], "value": 153.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 62.0, 61.0, 63.0, 61.0, 63.0, 62.0, 60.0, 63.0], "value": 62.2, "unit": "score"}], "name": "kraken", "value": 1460.1000000000001, "alertThreshold": 2.0}]} 15:10:55 INFO - Return code: 0 15:10:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:10:55 INFO - # TBPL SUCCESS # 15:10:55 INFO - Running post-action listener: _resource_record_post_action 15:10:55 INFO - [mozharness: 2016-12-20 23:10:55.857533Z] Finished run-tests step (success) 15:10:55 INFO - Running post-run listener: _resource_record_post_run 15:10:55 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 270336; Write bytes: 356577280; Read time: 36; Write time: 245492 15:10:55 INFO - TinderboxPrint: CPU usage
13.0% 15:10:55 INFO - TinderboxPrint: I/O read bytes / time
270,336 / 36 15:10:55 INFO - TinderboxPrint: I/O write bytes / time
356,577,280 / 245,492 15:10:55 INFO - TinderboxPrint: CPU idle
8,274.5 (87.0%) 15:10:55 INFO - TinderboxPrint: CPU user
1,194.2 (12.6%) 15:10:55 INFO - TinderboxPrint: Swap in / out
0 / 0 15:10:55 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 107274240; Read time: 0; Write time: 74960 15:10:55 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 266240; Write bytes: 246235136; Read time: 24; Write time: 169820 15:10:56 INFO - Running post-run listener: _upload_blobber_files 15:10:56 INFO - Blob upload gear active. 15:10:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:10:56 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 15:10:56 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:10:56 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:10:56 INFO - (blobuploader) - INFO - Open directory for files ... 15:10:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:10:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:10:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:10:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:10:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:10:58 INFO - (blobuploader) - INFO - Done attempting. 15:10:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:10:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:10:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:10:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:10:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:10:59 INFO - (blobuploader) - INFO - Done attempting. 15:10:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:10:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:10:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:11:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:11:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:11:02 INFO - (blobuploader) - INFO - Done attempting. 15:11:02 INFO - (blobuploader) - INFO - Iteration through files over. 15:11:02 INFO - Return code: 0 15:11:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:11:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:11:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0017a540f1e6d71f071d0431637595c02f3109213643af36d3b26ab6e495accb8110aa06caf34ac7dfaf0d1e916446337085a38a522c70c81a23b422658d8080", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/40cc7da2835521c6ddeac46da07b5cd1568bf25cfb33b6fce8a4d9feacd5dc08d5dca33e2ca15f17f1c262ebd9898056b32bd1598369c952450c58be0f32e430", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2426b814e62c67e6d6f8570e232008696a0a5af446b186ff1dcd9eaf80c45aa80f5040b5451dd7c4a8ccc03e89a17318b10cb8681dd5de2d3eef641ce54a53d0"} 15:11:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:11:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:11:02 INFO - Contents: 15:11:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0017a540f1e6d71f071d0431637595c02f3109213643af36d3b26ab6e495accb8110aa06caf34ac7dfaf0d1e916446337085a38a522c70c81a23b422658d8080", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/40cc7da2835521c6ddeac46da07b5cd1568bf25cfb33b6fce8a4d9feacd5dc08d5dca33e2ca15f17f1c262ebd9898056b32bd1598369c952450c58be0f32e430", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2426b814e62c67e6d6f8570e232008696a0a5af446b186ff1dcd9eaf80c45aa80f5040b5451dd7c4a8ccc03e89a17318b10cb8681dd5de2d3eef641ce54a53d0"} 15:11:02 INFO - Running post-run listener: copy_logs_to_upload_dir 15:11:03 INFO - Copying logs to upload dir... 15:11:03 INFO - mkdir: /builds/slave/test/build/upload/logs 15:11:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.981589 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-12-20 15:11:02.533623) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-20 15:11:02.540378) ========= 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=db7e7c15f3ca076d53731445000001ba-1482274222.659172-224554726 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0017a540f1e6d71f071d0431637595c02f3109213643af36d3b26ab6e495accb8110aa06caf34ac7dfaf0d1e916446337085a38a522c70c81a23b422658d8080", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/40cc7da2835521c6ddeac46da07b5cd1568bf25cfb33b6fce8a4d9feacd5dc08d5dca33e2ca15f17f1c262ebd9898056b32bd1598369c952450c58be0f32e430", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2426b814e62c67e6d6f8570e232008696a0a5af446b186ff1dcd9eaf80c45aa80f5040b5451dd7c4a8ccc03e89a17318b10cb8681dd5de2d3eef641ce54a53d0"} build_url:https://queue.taskcluster.net/v1/task/e7Row3e3Q8avAgCiBVqB2Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011620 build_url: 'https://queue.taskcluster.net/v1/task/e7Row3e3Q8avAgCiBVqB2Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0017a540f1e6d71f071d0431637595c02f3109213643af36d3b26ab6e495accb8110aa06caf34ac7dfaf0d1e916446337085a38a522c70c81a23b422658d8080", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/40cc7da2835521c6ddeac46da07b5cd1568bf25cfb33b6fce8a4d9feacd5dc08d5dca33e2ca15f17f1c262ebd9898056b32bd1598369c952450c58be0f32e430", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2426b814e62c67e6d6f8570e232008696a0a5af446b186ff1dcd9eaf80c45aa80f5040b5451dd7c4a8ccc03e89a17318b10cb8681dd5de2d3eef641ce54a53d0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-20 15:11:02.573780) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 15:11:02.574188) ========= 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=db7e7c15f3ca076d53731445000001ba-1482274222.659172-224554726 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004573 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 15:11:02.659050) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-20 15:11:02.659415) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-20 15:11:02.659749) ========= ========= Total master_lag: 0.20 =========